Page 1 of 1

[0.14.12] Desync when joining big game

Posted: Sat Oct 01, 2016 12:38 pm
by ili
Hi
Yesterday I played in "FACTORIO Vanilla Multiplayer Server [EU1]"
Now when I try to join it again I get Desync when getting in the game or a few seconds later
The game is big ~150MB

Reports ZIPs Link (4 reports):
https://mega.nz/#F!ct4lBAJB!MPXbusZbtIdo4WlFf2m-Tg

Also one time after the Desync I got this 500B/s limit bug?

I hope it helps

Re: [0.14.12] Desync when joining big game

Posted: Sat Oct 01, 2016 1:54 pm
by Loewchen
I don't understand why, when the game is 150MB big, it later on downloads a 10MB map.

Re: [0.14.12] Desync when joining big game

Posted: Sat Oct 01, 2016 2:19 pm
by ili
Loewchen wrote:I don't understand why, when the game is 150MB big, it later on downloads a 10MB map.
Yep it's strange, sometimes it downloaded a smaller file, maybe it downloads only the changes from the previous download?

Re: [0.14.12] Desync when joining big game

Posted: Sat Oct 01, 2016 11:02 pm
by rbtcollins
Bump - I'm seeing this on a mp game from the weekend.

Was in it working fine. left for a minute, can't get back in.

Code: Select all

   0.004 2016-10-02 11:56:16; Factorio 0.14.12 (build 24932, win64, steam)
   0.004 Operating system: Windows 10 
   0.004 Program arguments: "D:\SteamLibrary\steamapps\common\Factorio\bin\x64\Factorio.exe" 
   0.004 Read data path: D:/SteamLibrary/steamapps/common/Factorio/data
   0.004 Write data path: C:/Users/robertc/AppData/Roaming/Factorio
   0.004 Binaries path: D:/SteamLibrary/steamapps/common/Factorio/bin
   0.018 System info: [CPU: Intel(R) Core(TM) i7-5960X CPU @ 3.00GHz, 16 cores, RAM: 32655MB]
   0.019 Display options: [FullScreen: true] [VSync: false] [UIScale: 100%] [MultiSampling: OFF] [Screen: 0]
   0.023 Available display adapters: 2
   0.023  [0]: \\.\DISPLAY1 - NVIDIA GeForce GTX 980 {0x05, [0,0], 3840x2160, 32bit, 60Hz}
   0.023  [1]: \\.\DISPLAY2 - NVIDIA GeForce GTX 980 {0x01, [3840,0], 2160x3840, 32bit, 60Hz}
   0.024 Create display on adapter 0. Size 1280x720 at position [1270, 702].
   0.108 Initialised Direct3D:[0] NVIDIA GeForce GTX 980; driver: C:\WINDOWS\System32\DriverStore\FileRepository\nv_desktop_ref4i.inf_amd64_6d7341131fca00bc\nvd3dumx.dll 21.21.13.7270
   0.112     Video memory size (dedicated video/dedicated system/shared system/available): 4060/0/16327/4064 MB
   0.156 Device reset internal.
   0.161 Desktop composition is active.
   0.161 Graphics options: [Graphics quality: normal] [Video memory usage: high] [Light scale: 100%] [DXT: auto]
   0.288 Loading mod core 0.0.0 (data.lua)
   0.296 Loading mod base 0.14.12 (data.lua)
   0.410 Checksum for core: 1620335853
   0.410 Checksum for mod base: 2833886813
   0.690 Info PlayerData.cpp:55: Local player-data.json available, timestamp 1475362526
   0.690 Info PlayerData.cpp:60: Cloud player-data.json available, timestamp 1475362525
   0.829 Initial atlas bitmap size is 16384
   0.831 Created atlas bitmap 16384x3847
   0.891 Created atlas bitmap 4096x4088
   0.985 Created atlas bitmap 4096x4096
   1.067 Created atlas bitmap 4096x3960
   1.132 Created atlas bitmap 4096x968
   1.139 Created atlas bitmap 4096x3652
   9.946 Sprites loaded
   9.946 Convert atlas 4096x4088 to: compressed 
  10.619 Convert atlas 4096x4096 to: compressed 
  11.663 Convert atlas 4096x3960 to: compressed 
  12.298 Convert atlas 4096x968 to: trilinear-filtering 
  12.318 Convert atlas 4096x3652 to: mipmap 
  13.239 Loading sounds...
  14.876 Custom inputs active: 0
  14.945 Factorio initialised
  39.062 Info WindowsUDPSocket.cpp:61: Opening socket at port (0)
  52.337 Info WindowsUDPSocket.cpp:161: Socket closed
  52.339 Joining game 92.237.239.26:34197
  52.339 Info WindowsUDPSocket.cpp:61: Opening socket at port (0)
  52.340 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(Ready) to(Connecting)
  53.011 Connection refused
  53.011 Info ClientMultiplayerManager.cpp:177: Quitting multiplayer connection.
  53.012 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(Connecting) to(Disconnected)
  53.013 Info HttpSharedState.cpp:44: Downloading https://auth.factorio.com/generate-user-server-key
  54.003 Info HttpSharedState.cpp:108: Status code: 200
  54.003 Info AuthServerConnector.cpp:132: Received key(pZEJVLXfa+EDdK0zoZ76uQ==) for username(rbtcollins) from auth server.
  54.004 Info WindowsUDPSocket.cpp:161: Socket closed
  54.004 Joining game 92.237.239.26:34197
  54.004 Info WindowsUDPSocket.cpp:61: Opening socket at port (0)
  54.005 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(Ready) to(Connecting)
  54.694 Info ClientSynchronizer.cpp:33: Initialized Synchronizer local peer(1) latency(32).
  54.694 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(Connecting) to(ConnectedWaitingForMap)
  54.694 Info ClientRouter.cpp:217: ConnectionAccepted
  55.394 Info ClientMultiplayerManager.cpp:660: Received mapReadyForDownload
  55.394 Downloading file C:\Users\robertc\AppData\Roaming\Factorio\temp\mp-download.zip (9788436 B, 19461 blocks)
  55.398 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(ConnectedWaitingForMap) to(ConnectedDownloadingMap)
  61.444 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527548) tickClosures((tick(3413881) inputActions((CheckCRCHeuristic) ) ) (tick(3413882) inputActions((StopMovementInTheNextTick) (CheckCRCHeuristic) ) ) (tick(3413883) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  61.444 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527549) tickClosures((tick(3413884) inputActions((CheckCRCHeuristic) ) ) (tick(3413885) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  61.528 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527551) tickClosures((tick(3413888) inputActions((CheckCRCHeuristic) ) ) (tick(3413889) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  62.144 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527570) tickClosures((tick(3413931) inputActions((CheckCRCHeuristic) ) ) (tick(3413932) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  64.861 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527642) tickClosures((tick(3414093) inputActions((CheckCRCHeuristic) ) ) (tick(3414094) inputActions((CheckCRCHeuristic) ) ) (tick(3414095) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  67.577 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1527713) tickClosures((tick(3414253) inputActions((CheckCRCHeuristic) ) ) (tick(3414254) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
  71.127 Info TransferTarget.cpp:280: TIMEOUT!
  74.244 Info TransferTarget.cpp:280: TIMEOUT!
  76.956 Finished download (21 s, 9.7 MB, 454 kB/s)
  77.049 Info ClientMultiplayerManager.cpp:641: mapTick(-1) map download finished creating scenario
  77.049 Loading map C:\Users\robertc\AppData\Roaming\Factorio\temp\mp-download.zip
  77.049 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(ConnectedDownloadingMap) to(ConnectedLoadingMap)
  77.205 Info Scenario.cpp:152: Map version 0.14.12-1
  78.135 Checksum for script C:/Users/robertc/AppData/Roaming/Factorio/temp/currently-playing/control.lua: 900459546
  78.161 Info ClientMultiplayerManager.cpp:530: MapTick(3413601) changing state from(ConnectedLoadingMap) to(TryingToCatchUp)
  78.481 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3413751) serverCRC(-1894292555) localCRC(-1204663746)
  78.481 Info ClientMultiplayerManager.cpp:530: MapTick(3413752) changing state from(TryingToCatchUp) to(DesyncedWaitingForMap)
  78.484 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3413752) serverCRC(-1798436732) localCRC(-1575617988
...
snipped more of same
...
   80.911 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415010) serverCRC(-974792099) localCRC(1202980837)
  88.477 Info ClientMultiplayerManager.cpp:660: Received mapReadyForDownload
  88.477 Info ClientMultiplayerManager.cpp:530: MapTick(3415012) changing state from(DesyncedWaitingForMap) to(DesyncedCatchingUpWithMapReadyForDownload)
  88.477 Warning ClientMultiplayerManager.cpp:673: receivedScriptChecksums isn't empty when download starting.
  88.482 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(DesyncedCatchingUpWithMapReadyForDownload) to(DesyncedSavingLocalVariantOfMap)
 100.611 Downloading file C:\Users\robertc\AppData\Roaming\Factorio\temp\mp-download.zip (67523305 B, 134242 blocks)
 100.613 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(DesyncedSavingLocalVariantOfMap) to(DesyncedDownloadingMap)
 111.143 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1528901) tickClosures((tick(3416294) inputActions((CheckCRCHeuristic) ) ) (tick(3416295) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 111.877 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1528920) tickClosures((tick(3416337) inputActions((CheckCRCHeuristic) ) ) (tick(3416338) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 111.877 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1528921) tickClosures((tick(3416339) inputActions((CheckCRCHeuristic) ) ) (tick(3416340) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
 112.610 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1528940) tickClosures((tick(3416383) inputActions((CheckCRCHeuristic) ) ) (tick(3416384) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
 122.544 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529207) tickClosures((tick(3416979) inputActions((CheckCRCHeuristic) ) ) (tick(3416980) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 122.594 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529208) tickClosures((tick(3416981) inputActions((CheckCRCHeuristic) ) ) (tick(3416982) inputActions((CheckCRCHeuristic) ) ) (tick(3416983) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 124.078 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529248) tickClosures((tick(3417071) inputActions((CheckCRCHeuristic) ) ) (tick(3417072) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 124.895 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529267) tickClosures((tick(3417114) inputActions((CheckCRCHeuristic) ) ) (tick(3417115) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 124.895 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529268) tickClosures((tick(3417116) inputActions((CheckCRCHeuristic) ) ) (tick(3417117) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 124.944 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529269) tickClosures((tick(3417118) inputActions((CheckCRCHeuristic) ) ) (tick(3417119) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
 126.095 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529270) tickClosures((tick(3417120) inputActions((CheckCRCHeuristic) ) ) (tick(3417121) inputActions((CheckCRCHeuristic) ) ) (tick(3417122) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 126.727 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529303) tickClosures((tick(3417195) inputActions((CheckCRCHeuristic) ) ) (tick(3417196) inputActions((CheckCRCHeuristic) ) ) (tick(3417197) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 127.428 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529337) tickClosures((tick(3417271) inputActions((CheckCRCHeuristic) ) ) (tick(3417272) inputActions((CheckCRCHeuristic) ) ) (tick(3417273) inputActions((CheckCRCHeuristic) ) ) ) synchronizerActions((MapDownloadingProgressUpdate) ) ) requestsForHeartbeats() ) behind the latency window
 127.428 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529338) tickClosures((tick(3417274) inputActions((CheckCRCHeuristic) ) ) (tick(3417275) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 131.960 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529458) tickClosures((tick(3417543) inputActions((CheckCRCHeuristic) ) ) (tick(3417544) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 131.960 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529459) tickClosures((tick(3417545) inputActions((CheckCRCHeuristic) ) ) (tick(3417546) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 132.677 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529478) tickClosures((tick(3417588) inputActions((CheckCRCHeuristic) ) ) (tick(3417589) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 132.677 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529479) tickClosures((tick(3417590) inputActions((CheckCRCHeuristic) ) ) (tick(3417591) inputActions((CheckCRCHeuristic) ) ) (tick(3417592) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 132.695 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529480) tickClosures((tick(3417593) inputActions((CheckCRCHeuristic) ) ) (tick(3417594) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 143.061 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1529755) tickClosures((tick(3418204) inputActions((CheckCRCHeuristic) ) ) (tick(3418205) inputActions((CheckCRCHeuristic) ) ) (tick(3418206) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 157.077 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530134) tickClosures((tick(3419052) inputActions((CheckCRCHeuristic) ) ) (tick(3419053) inputActions((CheckCRCHeuristic) ) ) (tick(3419054) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 164.727 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530321) tickClosures((tick(3419472) inputActions((CheckCRCHeuristic) ) ) (tick(3419473) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 165.344 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530322) tickClosures((tick(3419474) inputActions((CheckCRCHeuristic) ) ) (tick(3419475) inputActions((CheckCRCHeuristic) ) ) (tick(3419476) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 165.360 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530336) tickClosures((tick(3419506) inputActions((CheckCRCHeuristic) ) ) (tick(3419507) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 165.360 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530337) tickClosures((tick(3419508) inputActions((CheckCRCHeuristic) ) ) (tick(3419509) inputActions((CheckCRCHeuristic) ) ) (tick(3419510) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 182.144 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530810) tickClosures((tick(3420518) inputActions((CheckCRCHeuristic) ) ) (tick(3420519) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 182.194 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530811) tickClosures((tick(3420520) inputActions((CheckCRCHeuristic) ) ) (tick(3420521) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 182.911 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530831) tickClosures((tick(3420565) inputActions((CheckCRCHeuristic) ) ) (tick(3420566) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 183.812 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1530851) tickClosures((tick(3420609) inputActions((CheckCRCHeuristic) ) ) (tick(3420610) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 191.777 Warning ClientSynchronizer.cpp:52: Ignoring heartbeat(type(ServerToClientHeartbeat) heartbeat(sequenceNumber(1531052) tickClosures((tick(3421058) inputActions((CheckCRCHeuristic) ) ) (tick(3421059) inputActions((CheckCRCHeuristic) ) ) ) ) requestsForHeartbeats() ) behind the latency window
 198.027 Info TransferTarget.cpp:280: TIMEOUT!
 201.243 Info TransferTarget.cpp:280: TIMEOUT!
 204.593 Finished download (103 s, 67 MB, 649 kB/s)
 205.011 Info ClientMultiplayerManager.cpp:641: mapTick(-1) map download finished creating scenario
 205.011 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(DesyncedDownloadingMap) to(DesyncedCreatingReport)
 211.249 Info ParallelDesyncReportCreator.cpp:64: Created desync report
 211.261 Loading map C:\Users\robertc\AppData\Roaming\Factorio\temp\mp-download.zip
 211.261 Info ClientMultiplayerManager.cpp:530: MapTick(-1) changing state from(DesyncedCreatingReport) to(ConnectedLoadingMap)
 211.322 Info Scenario.cpp:152: Map version 0.14.12-1
 212.312 Checksum for script C:/Users/robertc/AppData/Roaming/Factorio/temp/currently-playing/control.lua: 900459546
 212.345 Info ClientMultiplayerManager.cpp:530: MapTick(3415012) changing state from(ConnectedLoadingMap) to(TryingToCatchUp)
 212.371 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415013) serverCRC(884115557) localCRC(1645895759)
 212.371 Info ClientMultiplayerManager.cpp:530: MapTick(3415014) changing state from(TryingToCatchUp) to(DesyncedWaitingForMap)
 212.374 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415014) serverCRC(263296926) localCRC(766037511)
 ...
snipped more of same
...
 212.774 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415193) serverCRC(-1491007596) localCRC(-914216852)
 212.776 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415194) serverCRC(-1732062485) localCRC(-2050628678)
 212.778 Info ClientMultiplayerManager.cpp:654: mapTick(3415196) received player (25) desynced
 212.778 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415195) serverCRC(-370220803) localCRC(-1922730054)
 212.780 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3415196) serverCRC(546534739) localCRC(423479651)
...
snipping
...
 214.949 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416450) serverCRC(1584651557) localCRC(1849355667)
 214.951 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416451) serverCRC(825146390) localCRC(-1159755125)
 214.953 Info ClientMultiplayerManager.cpp:129: Disconnecting multiplayer connection.
 214.953 Info ClientMultiplayerManager.cpp:530: MapTick(3416453) changing state from(DesyncedWaitingForMap) to(DisconnectScheduled)
 214.954 Info ClientMultiplayerManager.cpp:530: MapTick(3416453) changing state from(DisconnectScheduled) to(DesyncedWaitingForMap)
 214.954 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416452) serverCRC(1450817965) localCRC(-1912988509)
 214.956 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416453) serverCRC(1793026730) localCRC(-1277584571)
...
snipping
...
 215.341 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416669) serverCRC(242799362) localCRC(-1954339127)
 215.342 Error GameActionHandler.cpp:2094: Multiplayer desynchronisation: crc test (heuristic) failed for crcTick(3416670) serverCRC(-2053276385) localCRC(-733555610)
 215.344 Info ClientMultiplayerManager.cpp:530: MapTick(3416672) changing state from(DesyncedWaitingForMap) to(Disconnected)
 215.344 Info ClientMultiplayerManager.cpp:763: Disconnect notification for peer (25)
 215.344 Info ClientSynchronizer.cpp:191: nextHeartbeatSequenceNumber(1508463513) cannot process synchronizer action(PlayerDesynced)
 215.344 Info ClientSynchronizer.cpp:191: nextHeartbeatSequenceNumber(1508463513) cannot process synchronizer action(SavingForUpdate)
 215.344 Info ClientSynchronizer.cpp:191: nextHeartbeatSequenceNumber(1508463513) cannot process synchronizer action(MapSavingProgressUpdate)
 215.632 Info WindowsUDPSocket.cpp:161: Socket closed

Re: [0.14.12] Desync when joining big game

Posted: Sat Oct 01, 2016 11:12 pm
by rbtcollins

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 6:58 am
by kovarex
Loewchen wrote:I don't understand why, when the game is 150MB big, it later on downloads a 10MB map.
Because the desync report got bigger (it is in the changelog).

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 7:14 am
by kovarex
Is the server still running? Is it still desyncing, do you have access to the server?

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 9:25 am
by Loewchen
kovarex wrote:Is the server still running? Is it still desyncing, do you have access to the server?
I connected and met the person who just restarted it...

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 2:08 pm
by ili
Loewchen wrote:
kovarex wrote:Is the server still running? Is it still desyncing, do you have access to the server?
I connected and met the person who just restarted it...
Yes it up
I tried again and got Desync again

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 2:38 pm
by kovarex
Could the server owner try the /toggle-heavy-mode command ?
If it generates any files into dumps, they might help a lot.

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 3:07 pm
by kovarex
kovarex wrote:Could the server owner try the /toggle-heavy-mode command ?
If it generates any files into dumps, they might help a lot.
I mean, it runs very slowly this way, on this save it is something like 10 seconds per tick, so leaving it in heavy mode for several hours might be necessary to produce anything helpful.

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 4:37 pm
by kovarex
Never mind, I eventually figured out what is going on and managed to reproduce the issue.

FINALLY! :)

Re: [0.14.12] Desync when joining big game

Posted: Sun Oct 02, 2016 5:18 pm
by kovarex
So this is fixed in for 0.14.13.

Re: [0.14.12] Desync when joining big game

Posted: Mon Oct 03, 2016 12:09 am
by Pirion
Should we still post desync issues...or should we retry next version?

Re: [0.14.12] Desync when joining big game

Posted: Mon Oct 03, 2016 9:43 am
by Smarty
Wait until 0.14.13 has been release and see if you can reproduce the desync

Re: [0.14.12] Desync when joining big game

Posted: Mon Oct 03, 2016 2:22 pm
by kovarex
We found and fixed 4 different desync causes in 0.14.12, so trying to investigate desync reports now would be probably a waste of time, we should release new version today or tomorrow, so we shall see.