Game freeze right after clicking the official proclamation

I was playing with the Ascendency.

The computer was under a fairly heavy load caused by a separate program – maybe that had an influence.

1 Like

Here is my settings files (user settings json and stonehearth.json), in case it is related to graphics settings:

user_settings.zip (1.2 KB)

It just happened again. :glum:

the game is frozen like this:

The music continues to play.

Here is my save game:
1522993639328.zip (3.8 MB)

steps to reproduce:

  1. load the above save
  2. dismiss the tutorial dialog
  3. click the “a strange bird” dialog thing when it arrives, click through the dialogs til they go away
  4. click the “official settlement declaration” dialog when it arrives
  5. use the random name button to choose a Great Name for the town
  6. select Banner Of Vitality
  7. click “Issue Declaration!” button

expected result:
celebration of the town’s declaration

actual result:
game is frozen. Fireworks sound effects play, but video is frozen. Game has to be “End Task”'d from the Windows Task Manager. RIP.

1 Like

Can you move the camera around and click on the UI?

I cannot move the camera. I can click on the UI but nothing visible changes except the mouse cursor.

It has the pointy finger over UI elements, but the UI visibly doesn’;t change, so it looks like the cursor changes for elements that I can’t see (like, if I click the crafter menu, the mouse cursor will change to the finger pointer when I move the mouse over where I know the Carpenter Crafter menu item should be). I wish I could show a screenshot, but the mouse isn’t present in screenshots.

1 Like

Similar issue

Screen will freeze after i chose my banner and issue declaration. The sound will continue to play and i can move my camera, but everything will be unresponsive. windows will later ask me to close the program.

Possible related:

:merry:

1 Like

Singeplayer latest version 24.9.2 windows 10 geforce gtx 1070 intel core i7 6700 skylake 3.4 ghz 8mb x64

Different types of scenario leading to crash:

  1. Crash as soon as the notification of the Bird pops up (usually at this stage i am on other menus (builders, citizens etc)

  2. Crash if i am playing on x3 and the notification pops up

  3. Play at x1 game speed, wait for the notification while not doing anything , waits until the fireworks are done and people start leaving the fireplace (at this point the game will freeze for 2 sec, if i click anything at all during the freeze, it will crash.

  4. situation 3, but i be patient with the freeze , the game will continue (only to crash a few minutes later - something about assertion will popup)

  5. save multiple times, crash, load game, and get past the fireworks , but no more daily checks for new citizens, capped at 5. (even after i reload save) , crash upon completion of my building (a small double storey with 2 sets of roof , it checked out in the building editor , but i believe the roof is bugged (2 engine errors which i just ignore), as citizens did not build the roof, but the (building complete - poof animation happen anyway , even without the roof , and as soon as the poof animation came up ,i crash).

I believe anything that i did too quickly (clicking anything, open any menus , changing speed of game) , while certain animations are going on (bird’s notification , firework celebration, completion of building - new building editor) will crash the game.

other crashes result from assertion errors.

If you post the assertions, they might be useful for diagnosing this. Also your stonehearth.log and/or crash.dmp after you get a crash (they’re located inside C:\Program Files (x86)\Steam\steamapps\common\Stonehearth).

2018-05-14 15:55:36.153130 | server | 1 | app | Stonehearth Version 0.24.0.841 (x64)
2018-05-14 15:55:36.154133 | server | 1 | core.config | user id is b45c7aaa-8d4a-11e6-b9d4-708bcd57611d
2018-05-14 15:55:36.154133 | server | 1 | core.config | session id is fc608d67-e177-4ac2-bdbf-d5020ed8c1c3
2018-05-14 15:55:36.154133 | server | 0 | app | Steam present.
2018-05-14 15:55:36.155136 | server | 0 | core.system | Initializing crash reporter
2018-05-14 15:55:38.281881 | server | 1 | resources | Modules are verified pristine.
2018-05-14 15:55:38.318987 | server | 0 | app | Running Stonehearth server on port 62190
2018-05-14 15:55:38.320985 | client | 0 | client.core | Connecting to local server…
2018-05-14 15:55:38.320985 | server | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-14 15:55:38.324998 | client | 1 | game_engine | Initializing OpenGL
2018-05-14 15:55:38.336026 | server | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-14 15:55:38.355077 | server | 0 | mod stonehearth.ai.service | enable_cpp_placeholders is on
2018-05-14 15:55:38.355077 | server | 0 | mod stonehearth.ai.service | enable_cpp_compound_action is on
2018-05-14 15:55:38.363099 | client | 1 | game_engine | Determining window placement
2018-05-14 15:55:38.363099 | client | 1 | game_engine | Selecting monitor at 960, 540
2018-05-14 15:55:38.363099 | client | 1 | game_engine | Creating OpenGL Window
2018-05-14 15:55:39.339723 | client | 1 | game_engine | Creating OpenGL Context
2018-05-14 15:55:39.340698 | client | 1 | game_engine | Finished OpenGL Initialization
2018-05-14 15:55:39.354736 | client | 1 | horde.general | Initializing GL2 backend using OpenGL driver ‘4.6.0 NVIDIA 397.64’ by ‘NVIDIA Corporation’ on ‘GeForce GTX 1070/PCIe/SSE2’
2018-05-14 15:55:39.535217 | client | 1 | browser | cef started.
2018-05-14 15:55:39.536224 | client | 1 | browser | Navigate called without an existing browser!
2018-05-14 15:55:39.539226 | thread7272 | 1 | browser | Doing a buffered navigation to http://radiant/stonehearth/ui/root/index.html
2018-05-14 15:55:39.586352 | client | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-14 15:55:39.596378 | client | 1 | client.core | user feedback is on
2018-05-14 15:55:39.597381 | client | 1 | network | client allocating new send buffer (total: 0)
2018-05-14 15:55:39.597381 | client | 0 | client.core | Authenticating…
2018-05-14 15:55:40.281662 | server | 0 | simulation.core | Making authentication request with provider: host
2018-05-14 15:55:40.281662 | server | 0 | simulation.core | Authentication successful, responding with session.
2018-05-14 15:55:40.281662 | server | 0 | simulation.core | {
“session” : {
“player_id” : “player_1”,
“client_id” : “host”,
“provider” : “host”
},
“state” : “configuring”
}
2018-05-14 15:55:40.282164 | server | 0 | mod stonehearth | Player ‘player_1’ joined
2018-05-14 15:55:40.331796 | server | 1 | network | server allocating new send buffer (total: 0)
2018-05-14 15:55:40.332798 | client | 0 | client.core | Authenticated
2018-05-14 15:55:40.336339 | client | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-14 15:55:40.964005 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:55:40.964005 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:55:41.020138 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:55:41.020630 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:56:23.130563 | server | 1 | mod stonehearth.world_generation | Trying to set game mode to stonehearth:game_mode:hard when it has already been set to stonehearth:game_mode:hard by host
2018-05-14 15:56:31.321623 | server | 0 | simulation.core | took 167 ms to process job list
2018-05-14 15:56:31.575809 | server | 0 | simulation.core | took 110 ms to process job list
2018-05-14 15:56:31.758284 | server | 0 | simulation.core | took 128 ms to process job list
2018-05-14 15:56:32.000494 | server | 0 | simulation.core | took 122 ms to process job list
2018-05-14 15:56:32.201058 | server | 0 | simulation.core | took 136 ms to process job list
2018-05-14 15:56:32.500605 | server | 0 | simulation.core | took 124 ms to process job list
2018-05-14 15:56:32.781852 | server | 0 | simulation.core | took 143 ms to process job list
2018-05-14 15:56:33.115293 | server | 0 | simulation.core | took 111 ms to process job list
2018-05-14 15:56:33.311817 | server | 0 | simulation.core | took 136 ms to process job list
2018-05-14 15:56:33.424114 | server | 0 | simulation.core | took 101 ms to process job list
2018-05-14 15:56:33.725415 | server | 0 | simulation.core | took 129 ms to process job list
2018-05-14 15:56:33.968562 | server | 0 | simulation.core | took 120 ms to process job list
2018-05-14 15:56:34.289917 | server | 0 | simulation.core | took 148 ms to process job list
2018-05-14 15:56:34.725630 | server | 0 | simulation.core | took 148 ms to process job list
2018-05-14 15:56:35.275621 | server | 0 | simulation.core | took 142 ms to process job list
2018-05-14 15:56:35.396506 | server | 0 | simulation.core | took 114 ms to process job list
2018-05-14 15:56:35.691279 | server | 0 | simulation.core | took 159 ms to process job list
2018-05-14 15:56:35.815107 | server | 0 | simulation.core | took 117 ms to process job list
2018-05-14 15:56:36.140030 | server | 0 | simulation.core | took 136 ms to process job list
2018-05-14 15:56:36.386685 | server | 0 | simulation.core | took 130 ms to process job list
2018-05-14 15:56:36.709082 | server | 0 | simulation.core | took 143 ms to process job list
2018-05-14 15:56:37.161886 | server | 0 | simulation.core | took 180 ms to process job list
2018-05-14 15:56:37.664285 | server | 0 | simulation.core | took 153 ms to process job list
2018-05-14 15:56:37.795152 | server | 0 | simulation.core | took 124 ms to process job list
2018-05-14 15:56:38.124052 | server | 0 | simulation.core | took 149 ms to process job list
2018-05-14 15:56:38.243871 | server | 0 | simulation.core | took 113 ms to process job list
2018-05-14 15:56:38.576266 | server | 0 | simulation.core | took 144 ms to process job list
2018-05-14 15:56:38.859030 | server | 0 | simulation.core | took 164 ms to process job list
2018-05-14 15:56:39.156320 | server | 0 | simulation.core | took 157 ms to process job list
2018-05-14 15:56:39.564436 | server | 0 | simulation.core | took 161 ms to process job list
2018-05-14 15:56:39.989566 | server | 0 | simulation.core | took 148 ms to process job list
2018-05-14 15:56:40.416238 | server | 0 | simulation.core | took 160 ms to process job list
2018-05-14 15:56:40.531592 | server | 0 | simulation.core | took 108 ms to process job list
2018-05-14 15:56:40.832909 | server | 0 | simulation.core | took 142 ms to process job list
2018-05-14 15:56:41.140778 | server | 0 | simulation.core | took 132 ms to process job list
2018-05-14 15:56:41.468701 | server | 0 | simulation.core | took 155 ms to process job list
2018-05-14 15:56:41.754976 | server | 0 | simulation.core | took 110 ms to process job list
2018-05-14 15:56:41.968043 | server | 0 | simulation.core | took 152 ms to process job list
2018-05-14 15:56:42.094392 | server | 0 | simulation.core | took 120 ms to process job list
2018-05-14 15:56:42.240364 | server | 0 | simulation.core | took 102 ms to process job list
2018-05-14 15:56:42.524633 | server | 0 | simulation.core | took 157 ms to process job list
2018-05-14 15:56:42.656986 | server | 0 | simulation.core | took 125 ms to process job list
2018-05-14 15:56:42.867126 | server | 0 | simulation.core | took 148 ms to process job list
2018-05-14 15:56:42.996971 | server | 0 | simulation.core | took 123 ms to process job list
2018-05-14 15:56:44.093043 | server | 0 | ai.execution_frame | (3983 Kaven Belltower) [stonehearth:top] ai slow start is 0
2018-05-14 15:56:44.160222 | server | 0 | simulation.core | took 378 ms to update game state
2018-05-14 15:56:44.160222 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:56:44.499127 | server | 0 | simulation.core | took 109 ms to update game state
2018-05-14 15:56:44.499127 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:56:44.657093 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:56:44.657093 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:56:44.704217 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:56:44.704217 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-14 15:56:57.896579 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:03.804000 | client | 1 | deferred | [deferred 67585 ‘[method obj:object://tmp/120 fn:32198 route:build_ladder]’] resolve called in non-wait state!
2018-05-14 15:57:07.412181 | client | 1 | rpc | critical error in http reactor: could not trace[trace 33249 5]
2018-05-14 15:57:20.134617 | client | 1 | rpc | critical error in http reactor: could not trace[trace 35712 5]
2018-05-14 15:57:26.164868 | client | 1 | rpc | critical error in http reactor: could not trace[trace 36953 5]
2018-05-14 15:57:32.055225 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:33.195858 | client | 1 | renderer.effects_list [(6667 Leona Carvad) effect:50 attach item] | failed to attach {{talisman}} item with id 234480 does not exist.
2018-05-14 15:57:33.196392 | client | 1 | renderer.effects_list [(6667 Leona Carvad) effect:50 attach item] | failed to attach {{talisman}} item with id 234480 does not exist.
2018-05-14 15:57:39.371098 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:46.210270 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:46.268926 | client | 1 | deferred | [deferred 85177 ‘[method obj:object://tmp/120 fn:40070 route:place_template]’] resolve called in non-wait state!
2018-05-14 15:57:48.366824 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:49.137894 | server | 0 | simulation.core | took 102 ms to update game state
2018-05-14 15:57:49.137894 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:53.657593 | client | 1 | rpc | critical error in http reactor: could not trace[trace 42623 fallow]
2018-05-14 15:57:55.453363 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:57:56.364868 | client | 1 | rpc | critical error in http reactor: could not trace[trace 43154 fallow]
2018-05-14 15:58:45.953918 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:59:10.333670 | server | 0 | simulation.core | took 17829 ms to update game state
2018-05-14 15:59:10.333670 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:59:10.417393 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:59:10.595394 | server | 1 | ai.execution_unit | (2903 Chopper Vondess) [pickup item type] duplicate “set_think_output” in state ready
2018-05-14 15:59:20.151818 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:59:38.760832 | server | 0 | simulation.core | took 164 ms to update game state
2018-05-14 15:59:38.760832 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 15:59:42.534969 | client | 0 | renderer.render_info | stacked matrix Matrix_299 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-14 15:59:42.534969 | client | 0 | renderer.render_info | stacked matrix Matrix_299 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-14 15:59:42.535471 | client | 0 | renderer.render_info | stacked matrix Matrix_299 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-14 15:59:42.535471 | client | 0 | renderer.render_info | stacked matrix Matrix_299 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-14 15:59:53.380109 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:17.138597 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:24.912524 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:27.119986 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:29.222788 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:33.767657 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:38.844309 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:46.012366 | client | 1 | rpc | critical error in http reactor: could not trace[trace 77237 5]
2018-05-14 16:00:47.623697 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:00:51.658686 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:01:01.179016 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-14 16:01:01.179495 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-14 16:01:01.179996 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-14 16:01:19.702661 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:01:25.044824 | client | 1 | rpc | critical error in http reactor: could not trace[trace 83882 5]
2018-05-14 16:01:39.654451 | server | 0 | simulation.core | took 116 ms to process job list
2018-05-14 16:01:42.096202 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:01:46.561746 | server | 0 | simulation.core | Starting save.
2018-05-14 16:01:47.191434 | server | 0 | simulation.core | Saved.
2018-05-14 16:01:47.193434 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:01:47.202951 | client | 1 | client.core | clearing save deferred pointers
2018-05-14 16:02:12.503413 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:12.869853 | client | 1 | rpc | critical error in http reactor: could not trace[trace 92072 5]
2018-05-14 16:02:22.045279 | client | 1 | deferred | [deferred 200516 ‘[method obj:object://tmp/120 fn:93521 route:build_ladder]’] resolve called in non-wait state!
2018-05-14 16:02:24.320952 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:35.211625 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:35.670848 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:39.313227 | server | 0 | simulation.core | took 113 ms to update game state
2018-05-14 16:02:39.313227 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:40.693900 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:41.889578 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:43.542774 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:43.803484 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:46.092645 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:02:50.715072 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:03:00.348750 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:03:10.561687 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:03:18.537196 | client | 0 | app | Assertion Failed: rotate.is_unit()(C:\rb\ihome\root\SH-OB0-BUILD\stonehearth\source\csg\matrix4.cpp:510)
2018-05-14 16:03:19.540777 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-14 16:03:19.593405 | server | 1 | simulation.remote_client | started buffering client updates. (seq:8448 ack:8428)
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Memory Stats: Fatal Exception
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Total System Memory: 15.917 GB (17090822144 bytes)
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Current Memory Usage: 1.545 GB (1658437632 bytes)
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Total Address Space: 128.000 TB (140737488224256 bytes)
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Available Address Space: 127.998 TB (140734804090880 bytes)
2018-05-14 16:03:22.999173 | client | 0 | sysinfo | Used Address Space: 2.500 GB (2684133376 bytes)

1 Like

Thanks for the log!

I’ve merged the reports even though the crashes might not be related. But they happen around the proclamation so they probably have a similar cause.

I’ve just load up the previous save today and i think it crashed around the time when the checks are performed for a new citizen to arrive.

2018-05-19 11:39:55.384409 | server | 1 | app | Stonehearth Version 0.24.0.843 (x64)
2018-05-19 11:39:55.386633 | server | 1 | core.config | user id is b45c7aaa-8d4a-11e6-b9d4-708bcd57611d
2018-05-19 11:39:55.386633 | server | 1 | core.config | session id is abd4e80d-ae1f-4c84-a3ea-7e0029490207
2018-05-19 11:39:55.386633 | server | 0 | app | Steam present.
2018-05-19 11:39:55.386633 | server | 0 | core.system | Initializing crash reporter
2018-05-19 11:40:02.184942 | server | 1 | resources | Modules are verified pristine.
2018-05-19 11:40:02.276551 | server | 0 | app | Running Stonehearth server on port 56295
2018-05-19 11:40:02.284796 | client | 0 | client.core | Connecting to local server…
2018-05-19 11:40:02.310118 | server | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-19 11:40:02.327314 | client | 1 | game_engine | Initializing OpenGL
2018-05-19 11:40:02.438026 | client | 1 | game_engine | Determining window placement
2018-05-19 11:40:02.438026 | client | 1 | game_engine | Selecting monitor at 960, 540
2018-05-19 11:40:02.438026 | client | 1 | game_engine | Creating OpenGL Window
2018-05-19 11:40:02.905382 | client | 1 | game_engine | Creating OpenGL Context
2018-05-19 11:40:02.905382 | client | 1 | game_engine | Finished OpenGL Initialization
2018-05-19 11:40:02.952509 | client | 1 | horde.general | Initializing GL2 backend using OpenGL driver ‘4.6.0 NVIDIA 397.64’ by ‘NVIDIA Corporation’ on ‘GeForce GTX 1070/PCIe/SSE2’
2018-05-19 11:40:03.167223 | server | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-19 11:40:03.274561 | server | 0 | mod stonehearth.ai.service | enable_cpp_placeholders is on
2018-05-19 11:40:03.274561 | server | 0 | mod stonehearth.ai.service | enable_cpp_compound_action is on
2018-05-19 11:40:06.884901 | client | 1 | browser | cef started.
2018-05-19 11:40:06.886873 | client | 1 | browser | Navigate called without an existing browser!
2018-05-19 11:40:07.171103 | thread11340 | 1 | browser | Doing a buffered navigation to http://radiant/stonehearth/ui/root/index.html
2018-05-19 11:40:07.522457 | client | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-19 11:40:07.804774 | client | 1 | client.core | user feedback is on
2018-05-19 11:40:07.940167 | client | 1 | network | client allocating new send buffer (total: 0)
2018-05-19 11:40:07.972323 | client | 0 | client.core | Authenticating…
2018-05-19 11:40:08.017480 | server | 0 | simulation.core | Making authentication request with provider: host
2018-05-19 11:40:08.056608 | server | 0 | simulation.core | Authentication successful, responding with session.
2018-05-19 11:40:08.056608 | server | 0 | simulation.core | {
“session” : {
“player_id” : “player_1”,
“client_id” : “host”,
“provider” : “host”
},
“state” : “configuring”
}
2018-05-19 11:40:08.242215 | server | 1 | mod stonehearth.build.building_monitor | inventory was not present for player player_1
2018-05-19 11:40:08.242717 | server | 0 | mod stonehearth | Player ‘player_1’ joined
2018-05-19 11:40:08.250237 | server | 1 | network | server allocating new send buffer (total: 0)
2018-05-19 11:40:08.251741 | client | 0 | client.core | Authenticated
2018-05-19 11:40:08.254787 | client | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-19 11:40:10.045761 | server | 0 | simulation.core | took 167 ms to flush streamer
2018-05-19 11:40:10.063307 | server | 1 | simulation.remote_client | started buffering client updates. (seq:75 ack:0)
2018-05-19 11:40:10.466894 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:10.466894 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:10.621221 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:10.621723 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:10.670375 | server | 1 | simulation.remote_client | stopped buffering client updates. (seq:75 ack:75)
2018-05-19 11:40:25.544253 | client | 0 | client.core | loading save “auto_save”:
2018-05-19 11:40:25.544253 | client | 0 | client.core | {
2018-05-19 11:40:25.544253 | client | 0 | client.core | “name” : "Auto save: ",
2018-05-19 11:40:25.544253 | client | 0 | client.core | “town_name” : “Bug Please”,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “game_date” : {
2018-05-19 11:40:25.544253 | client | 0 | client.core | “day” : 2,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “month” : 2,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “year” : 1000,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “hour” : 1,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “minute” : 48
2018-05-19 11:40:25.544253 | client | 0 | client.core | },
2018-05-19 11:40:25.544253 | client | 0 | client.core | “timestamp” : 1526284906366,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “time” : “5/14/2018, 4:01:46 PM”,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “jobs” : {
2018-05-19 11:40:25.544253 | client | 0 | client.core | “crafters” : 1,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “workers” : 3,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “soldiers” : 1
2018-05-19 11:40:25.544253 | client | 0 | client.core | },
2018-05-19 11:40:25.544253 | client | 0 | client.core | “version” : “0.24.0.841”,
2018-05-19 11:40:25.544253 | client | 0 | client.core | “save_version” : 12
2018-05-19 11:40:25.544253 | client | 0 | client.core | }
2018-05-19 11:40:26.584520 | server | 1 | simulation.remote_client | started buffering client updates. (seq:399 ack:379)
2018-05-19 11:40:27.212693 | client | 1 | resources | Modules are verified pristine.
2018-05-19 11:40:27.246282 | cef | 1 | browser | Load error: -3
2018-05-19 11:40:27.273394 | client | 0 | core.system | not tested C:\rb\ihome\root\SH-OB0-BUILD\stonehearth\source\game_engine\legacy_game_engine\horde_render_node.cpp 165
2018-05-19 11:40:27.320993 | client | 1 | lua.code | Shutting down script host.
2018-05-19 11:40:27.361646 | client | 1 | lua.code | Script host destroyed.
2018-05-19 11:40:27.368666 | client | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-19 11:40:27.414286 | server | 0 | om.entity | Reference still exists to (1) after destroy_entity was called
2018-05-19 11:40:27.416292 | server | 1 | simulation.core | All entities have been destroyed.
2018-05-19 11:40:27.416292 | server | 1 | simulation.core | Shutting down traces.
2018-05-19 11:40:27.416292 | server | 1 | simulation.core | Shutting down game objects.
2018-05-19 11:40:27.416292 | server | 1 | simulation.core | All entities and datastores have been destroyed.
2018-05-19 11:40:27.416292 | server | 1 | lua.code | Shutting down script host.
2018-05-19 11:40:27.446913 | server | 1 | lua.code | Script host destroyed.
2018-05-19 11:40:27.446913 | server | 1 | simulation.core | Shutting down data objects.
2018-05-19 11:40:29.268813 | server | 1 | resources | Modules are verified pristine.
2018-05-19 11:40:29.300398 | server | 0 | physics.navgrid | subspace pathfinder is enabled
2018-05-19 11:40:29.306414 | server | 0 | simulation.core | Loading save: “auto_save”
2018-05-19 11:40:29.309922 | server | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-19 11:40:30.241046 | server | 1 | dm.store | load progress 99%…
2018-05-19 11:40:30.241549 | client | 1 | rpc | received reply with unknown call id ‘10’
2018-05-19 11:40:30.241549 | client | 1 | client.core | server reported load progress of 99%
2018-05-19 11:40:30.265612 | server | 1 | dm.store | load objects finished!

2018-05-19 11:40:30.269121 | server | 0 | dm.store | took 0.943 seconds to load
2018-05-19 11:40:30.269622 | server | 1 | network | server allocating new send buffer (total: 0)
2018-05-19 11:40:30.271126 | client | 0 | client.core | Server restart finished.
2018-05-19 11:40:30.274134 | client | 1 | mod radiant | lua controller lifetime tracking set to “nil”
2018-05-19 11:40:31.893477 | server | 0 | mod stonehearth.ai.service | enable_cpp_placeholders is on
2018-05-19 11:40:31.893477 | server | 0 | mod stonehearth.ai.service | enable_cpp_compound_action is on
2018-05-19 11:40:31.896987 | server | 0 | mod stonehearth.terrain | orc_npcs explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | human_npcs explored region contains 9 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | rabbit_biped_npcs explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | forest explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | goblins explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | animals explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | amberstone explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | orcs explored region contains 0 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | undead explored region contains 5 rects
2018-05-19 11:40:31.897502 | server | 0 | mod stonehearth.terrain | player_1 explored region contains 12 rects
2018-05-19 11:40:33.071111 | server | 1 | network | server allocating new send buffer (total: 0)
2018-05-19 11:40:33.589488 | server | 1 | network | server allocating new send buffer (total: 1)
2018-05-19 11:40:33.658674 | server | 0 | simulation.core | took 587 ms to flush streamer
2018-05-19 11:40:35.328268 | server | 0 | simulation.core | finished loading game
2018-05-19 11:40:35.328268 | server | 0 | mod stonehearth | Player ‘player_1’ joined
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Memory Stats: Finished Loading Simulation
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Total System Memory: 15.917 GB (17090822144 bytes)
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Current Memory Usage: 846.129 MB (887230464 bytes)
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Total Address Space: 128.000 TB (140737488224256 bytes)
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Available Address Space: 127.999 TB (140735947431936 bytes)
2018-05-19 11:40:35.328761 | server | 0 | sysinfo | Used Address Space: 1.435 GB (1540792320 bytes)
2018-05-19 11:40:35.548371 | client | 0 | client.core | reporting client load progress 77.75%…
2018-05-19 11:40:35.620563 | client | 0 | client.core | reporting client load progress 80.5%…
2018-05-19 11:40:35.699774 | client | 0 | client.core | reporting client load progress 83.25%…
2018-05-19 11:40:35.771965 | client | 0 | client.core | reporting client load progress 86%…
2018-05-19 11:40:35.834601 | client | 0 | client.core | reporting client load progress 88.75%…
2018-05-19 11:40:35.856192 | server | 0 | ai.execution_frame | (6123 Cecily Umbro) [stonehearth:top] ai slow start is 0
2018-05-19 11:40:35.903310 | client | 0 | client.core | reporting client load progress 91.5%…
2018-05-19 11:40:35.963973 | client | 0 | client.core | reporting client load progress 94.25%…
2018-05-19 11:40:36.038172 | client | 0 | client.core | reporting client load progress 97%…
2018-05-19 11:40:36.149968 | client | 0 | client.core | reporting client load progress 99.75%…
2018-05-19 11:40:36.655182 | client | 0 | client.core | SetCurrentUIScreen to restart
2018-05-19 11:40:36.784152 | server | 0 | simulation.core | took 1043 ms to update game state
2018-05-19 11:40:36.784152 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:37.030864 | client | 0 | renderer.render_info | stacked matrix Matrix_299 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-19 11:40:37.031365 | client | 0 | renderer.render_info | stacked matrix Matrix_299 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-19 11:40:37.031365 | client | 0 | renderer.render_info | stacked matrix Matrix_299 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-19 11:40:37.031365 | client | 0 | renderer.render_info | stacked matrix Matrix_299 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-19 11:40:38.420510 | client | 0 | client.core | Changed UI Screen after load
2018-05-19 11:40:38.990673 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-19 11:40:38.991175 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-19 11:40:38.991678 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-19 11:40:39.161533 | server | 1 | simulation.remote_client | stopped buffering client updates. (seq:416 ack:416)
2018-05-19 11:40:39.192664 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:39.192664 | client | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:39.211715 | server | 1 | simulation.remote_client | started buffering client updates. (seq:463 ack:416)
2018-05-19 11:40:39.313245 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:39.313245 | server | 1 | lua.code | unrecognized object type ‘boxed’ in json_to_lua!
2018-05-19 11:40:39.362877 | server | 1 | simulation.remote_client | stopped buffering client updates. (seq:463 ack:463)
2018-05-19 11:40:48.245853 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:48.417361 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:49.094207 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:49.212018 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:49.269238 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:40:53.743729 | client | 1 | deferred | [deferred 23649 ‘[method obj:object://tmp/120 fn:11037 route:build_ladder]’] resolve called in non-wait state!
2018-05-19 11:41:11.907971 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:41:25.499311 | client | 1 | rpc | critical error in http reactor: could not trace[trace 17673 5]
2018-05-19 11:41:53.825893 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:42:11.371539 | client | 0 | renderer.render_info | stacked matrix Matrix_301 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-19 11:42:11.371539 | client | 0 | renderer.render_info | stacked matrix Matrix_301 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-19 11:42:11.372039 | client | 0 | renderer.render_info | stacked matrix Matrix_301 size (10, 10, 10) does not match first matrix size of (10, 2, 10)
2018-05-19 11:42:11.372039 | client | 0 | renderer.render_info | stacked matrix Matrix_301 pos (-5, 2, -5) does not match first matrix pos of (-5, 0, -5)
2018-05-19 11:42:13.801578 | client | 1 | rpc | critical error in http reactor: could not trace[trace 26393 5]
2018-05-19 11:42:32.147483 | server | 1 | mod stonehearth.combat | Aborting attack. Global_attack_recovery on (2339 Ollen Jondal) still not expired.
2018-05-19 11:42:34.343297 | client | 1 | horde.general | over_lifetime_[rgb] properties are no longer supported. Use a single over_lifetime property.
2018-05-19 11:42:34.886742 | server | 1 | mod stonehearth.combat | Aborting attack. Global_attack_recovery on (2339 Ollen Jondal) still not expired.
2018-05-19 11:43:34.369535 | client | 1 | rpc | critical error in http reactor: could not trace[trace 42029 5]
2018-05-19 11:44:26.088161 | server | 0 | simulation.core | took 49350 ms to update game state
2018-05-19 11:44:26.088161 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:44:27.079903 | client | 0 | app | Assertion Failed: ((char *)next - _base) <= _len(C:\rb\ihome\root\SH-OB0-BUILD\stonehearth\source\resources\animation.cpp:191)
2018-05-19 11:44:28.121662 | server | 1 | simulation.remote_client | started buffering client updates. (seq:4000 ack:3980)
2018-05-19 11:44:43.347592 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:44:46.155958 | server | 1 | simulation.core | game loop exhausted before any jobs processed!
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Memory Stats: Fatal Exception
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Total System Memory: 15.917 GB (17090822144 bytes)
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Current Memory Usage: 1.290 GB (1384706048 bytes)
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Total Address Space: 128.000 TB (140737488224256 bytes)
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Available Address Space: 127.998 TB (140735369408512 bytes)
2018-05-19 11:44:50.553395 | client | 0 | sysinfo | Used Address Space: 1.973 GB (2118815744 bytes)

Looks like a corrupted animation file. If running Steam’s verify game file validity doesn’t fix it, can you upload the problematic save? And did you have any mods enabled on that save before?

auto_save.rar (2.8 MB)

Is this the save file?

I’ve just verified the game files, and on my second run i have the same issue. At 10.21am in game time, the screen will freeze for few seconds , though i can still move the camera around. Then the bug will come up after it stops freezing.

I dont run any mods.

I tried loading this a few times and letting the game run unattended for two ingame days, but couldn’t reproduce the issue. We’ll take a deeper look later.

I am having the same problem. All visuals freeze except for the mouse cursor during/right after the official town proclamation. Audio runs and I can hear my hearthlings still working in the background and picking up tools to claim jobs. The game is running but video is frozen. I am not sure how to upload a save, if someone could point in the direction of some instructions I’ll be glad to upload it.

I reloaded the save and made sure to look away from the golden particle effects for the town proclamation celebration (at the town center) and it seemed to work. No freeze and the game went on fine. But as soon as night hit and my hearthling lit the log for the fire, which I was looking at, the game froze again. So I think it might be something to do with lighting itself, but I’m no programmer.

1 Like

That’s a very useful detail, thanks! Can you post your machine specs, in particular your graphics card?