[0.12.33] [Pending]desync every 60 ticks - no map redownload

This subforum contains all the issues which we already resolved.
daniel34
Global Moderator
Global Moderator
Posts: 2761
Joined: Thu Dec 25, 2014 7:30 am
Contact:

[0.12.33] [Pending]desync every 60 ticks - no map redownload

Post by daniel34 »

Yesterday night the strangest thing occured on my dedicated server, after some initial desyncs the map continued seemingly normal with three (later two) players for around 2 hours. Then they all cleanly left. Upon reconnect today they noticed that the map was still in a state before the 2 hours (the changes were lost).

To the players this looks like a reload of an earlier save, but the server hasn't been restarted (continuous logfile). Opening the log file reveals that the server has been desyncing every 60 ticks (every second) during these lost 2 hours, without any map download to resync inbetween. I think the server ran its own simulation without the changes made by peers during that time.

List of events (by log seconds):
3 players are already on the server (48 - kaZ, 49 - Smarty, 50 - Lotny)
  • 292757 - peer 51 (Loewchen) joins
  • 292933 - map download finished - is InGame
  • 293091 - Loewchen desyncs
    Desync specification: Reference CRC = 4202485537, reference peers = {0, 48 (kaZ), 49 (Smarty), 50 (Lotny)}; desynced CRC = 2214895495, desynced peer = 51 (Loewchen)
  • 293258 - Loewchen has redownloaded and is InGame
  • 293260 - the other 3 peers desync
    Desync specification: Reference CRC = 2058056068, reference peers = {0, 51 (Loewchen)}; desynced CRC = 4163086446, desynced peer = 48 (kaZ)desynced CRC = 4163086446, desynced peer = 49 (Smarty)desynced CRC = 4163086446, desynced peer = 50 (Lotny)
  • 293286 - Loewchen closes the game and is dropped out, all the peers are InGame again
  • 293286 - Starting from here, a desync happens every 60 mapTicks (same as the one above but without Loewchen)
  • 298655 - peer 48 (kaZ) leaves
    From that point on the desync still happens the same, but only with the remaining two peers
  • 301397 - peers 49 (Smarty) and 50 (Lotny) leave, server pauses as expected
No desyncs have happened since then.

Given that the mapTick progresses during that time and doesn't revert back at some time it's evident that the save hasn't been reset, but the players' changes have been lost. What I think happened is that after the server started to desync the server and the 3 peers (as a group, they always have the same CRC) ran different simulations and due to these diverging paths the actions of the peers couldn't be / haven't been made on the server simulation.
After they left only the server simulation was kept and new players got the server's simulation path.

The server is still running with 0.12.33, but the changelog doesn't lead me to believe that this bug or anything similar has been fixed in 0.12.35. I'm also aware that this will probably end up in 1 / 0 magic but I think the devs should be aware of this bug or at least the possibility of something like this happening.

EDIT: After reading the client log Smarty posted the peers see themselves as reference peers but the server sees itself as reference peer ("it's the other's fault"). Might that have something to do with it?
Attachments
factorio-current.zip
(327.62 KiB) Downloaded 128 times
quick links: log file | graphical issues | wiki
User avatar
Smarty
Global Moderator
Global Moderator
Posts: 816
Joined: Sat Oct 04, 2014 5:00 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Smarty »

added client log
Attachments
factorio-previous.log
(4.66 MiB) Downloaded 123 times
Loewchen
Global Moderator
Global Moderator
Posts: 9236
Joined: Wed Jan 07, 2015 5:53 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Loewchen »

From the desync-report (first desync):

Code: Select all

   
   0.002 2016-06-05 00:04:01; Factorio 0.12.33 (Build 18092, win64, alpha)
   0.002 Operating system: Windows 7 Service Pack 1
   0.002 Program arguments: "C:\Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\bin\x64\Factorio.exe" 
   0.002 Read data path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/data
   0.002 Write data path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting
   0.002 Binaries path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/bin
   0.021 Graphics options: [FullScreen: true] [VSync: true] [UIScale: 95%] [MultiSampling: OFF] [Graphics quality: low] [Video memory usage: all] [Light scale: 20%] [Screen: 255]
   0.022 Available display adapters: 1
   0.022  [0]: \\.\DISPLAY1 - NVIDIA GeForce GTX 560 Ti   {0x05, [0,0], 1920x1080, 32bit, 60Hz}
   0.022 Create display on adapter 0. Size 1280x720 at position [310, 162].
   0.126 Initialised Direct3D:[0] NVIDIA GeForce GTX 560 Ti  ; driver: nvd3dumx.dll 9.18.13.4052
   0.171 Desktop composition is active.
   0.234 Loading mod core 0.0.0 (data.lua)
   0.238 Loading mod base 0.12.33 (data.lua)
   0.335 Loading mod air-filtering 0.3.2 (data.lua)
   0.376 Loading mod hardCrafting 0.3.14 (data.lua)
   0.430 Loading mod Larger Inventory 1.0.0 (data.lua)
   0.472 Loading mod rocketAutoStarter 0.1.0 (data.lua)
   0.517 Loading mod hardCrafting 0.3.14 (data-updates.lua)
   0.567 Loading mod rso-mod 1.5.6 (data-updates.lua)
   0.609 Loading mod hardCrafting 0.3.14 (data-final-fixes.lua)
   0.662 Checksum for core: 3711505753
   0.662 Checksum for mod base: 2829195351
   0.662 Checksum for mod air-filtering: 1717915892
   0.662 Checksum for mod hardCrafting: 3423309532
   0.662 Checksum for mod Larger Inventory: 32563986
   0.662 Checksum for mod rocketAutoStarter: 2195749245
   0.662 Checksum for mod rso-mod: 4065594479
   1.089 Initial atlas bitmap size is 16384
   1.091 Created atlas bitmap 16384x3509
   6.719 Sprites loaded
   6.800 Loading sounds...
   8.399 Factorio initialised
  10.851 Info Router.cpp:509: Router peerID(65535) shutting down.
  10.856 Info Router.cpp:536: Router state -> Disconnected
  10.856 Joining game 176.31.245.226:34198 at port 34197
  10.856 Info WindowsUDPSocket.cpp:73: Opening socket at port (34197)
  10.858 Info Router.cpp:536: Router state -> Connecting
  10.859 Info MultiplayerManager.cpp:913: networkTick(0) mapTick(-1) changing state from(Ready) to(Connecting)
  10.936 Info Router.cpp:536: Router state -> WaitingForAccept
  11.038 Info Synchronizer.cpp:54: NetworkTick(17173639) initialized Synchronizer local peer(51) latency(6).
  11.038 Info Synchronizer.cpp:500: networkTick(17173639) adding peer(0) success(true).
  11.038 Info Synchronizer.cpp:500: networkTick(17173639) adding peer(48) success(true).
  11.039 Info Synchronizer.cpp:500: networkTick(17173639) adding peer(49) success(true).
  11.039 Info Synchronizer.cpp:500: networkTick(17173639) adding peer(50) success(true).
  11.039 Info Router.cpp:536: Router state -> Connected
  11.039 Info Router.cpp:729: ConnectionAccepted ownPeerID(51) nextPeerID(52)
  11.039 Info MultiplayerManager.cpp:913: networkTick(17173639) mapTick(-1) changing state from(Connecting) to(VerifyingConnection)
  11.124 Info Router.cpp:741: Received onPeerConnected for already connected peer(51)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(0) username(<server>).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(0) oldState(Ready) newState(InGame)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(48) username(kaZ).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(48) oldState(Ready) newState(InGame)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(49) username(Smarty).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(49) oldState(Ready) newState(InGame)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(50) username(Lotny).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(50) oldState(Ready) newState(InGame)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(51) username(Loewchen).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Ready) newState(Connecting)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(51) username(Loewchen).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Connecting) newState(Connecting)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(51) username(Loewchen).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Connecting) newState(Connecting)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(51) username(Loewchen).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Connecting) newState(Connecting)
  11.226 Info MultiplayerManager.cpp:1433: Received peer info for peer(51) username(Loewchen).
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Connecting) newState(Connecting)
  11.226 Info MultiplayerManager.cpp:1060: networkTick(17173645) mapTick(-1) received stateChanged peerID(51) oldState(Connecting) newState(VerifyingConnection)
  11.515 Info MultiplayerManager.cpp:913: networkTick(17173652) mapTick(-1) changing state from(VerifyingConnection) to(ConnectedWaitingForMap)
  11.616 Info MultiplayerManager.cpp:1060: networkTick(17173658) mapTick(-1) received stateChanged peerID(51) oldState(VerifyingConnection) newState(ConnectedWaitingForMap)
  11.718 Info MultiplayerManager.cpp:1060: networkTick(17173664) mapTick(-1) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  11.719 Info MultiplayerManager.cpp:1060: networkTick(17173664) mapTick(-1) received stateChanged peerID(48) oldState(InGame) newState(InGameAligning)
  11.719 Info MultiplayerManager.cpp:1060: networkTick(17173664) mapTick(-1) received stateChanged peerID(49) oldState(InGame) newState(InGameAligning)
  11.719 Info MultiplayerManager.cpp:1060: networkTick(17173664) mapTick(-1) received stateChanged peerID(50) oldState(InGame) newState(InGameAligning)
  12.041 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  12.041 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  12.041 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(48) oldState(InGameAligning) newState(InGameAligned)
  12.041 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(48) oldState(InGameAligned) newState(InGameWaitingForOthers)
  12.041 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(49) oldState(InGameAligning) newState(InGameAligned)
  12.042 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(49) oldState(InGameAligned) newState(InGameWaitingForOthers)
  12.042 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(50) oldState(InGameAligning) newState(InGameAligned)
  12.042 Info MultiplayerManager.cpp:1060: networkTick(17173677) mapTick(-1) received stateChanged peerID(50) oldState(InGameAligned) newState(InGameWaitingForOthers)
  19.143 Info MultiplayerManager.cpp:1060: networkTick(17174061) mapTick(-1) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  19.143 Downloading file C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip (48267634 B, 39499 blocks)
  19.149 Info MultiplayerManager.cpp:913: networkTick(17174061) mapTick(-1) changing state from(ConnectedWaitingForMap) to(ConnectedDownloadingMap)
  19.149 Info NetworkInputHandler.cpp:45: mapTick(69012791) networkTick(17174061) initialized NetworkInputHandler local peer(51).
  19.149 Info NetworkInputHandler.cpp:520: expectedMapTick(69012791) adding peer(0).
  19.149 Info NetworkInputHandler.cpp:520: expectedMapTick(69012791) adding peer(48).
  19.149 Info NetworkInputHandler.cpp:520: expectedMapTick(69012791) adding peer(49).
  19.149 Info NetworkInputHandler.cpp:520: expectedMapTick(69012791) adding peer(50).
  19.149 Info Synchronizer.cpp:413: NetworkTick(17174061) mapTick(69012791) applying 35 pending tickClosures
  19.149 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(0)
  19.149 Info NetworkInputHandler.cpp:599: assigning playerIndex(2) to peer(48)
  19.149 Info NetworkInputHandler.cpp:599: assigning playerIndex(4) to peer(49)
  19.149 Info NetworkInputHandler.cpp:599: assigning playerIndex(99) to peer(50)
  19.149 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(51)
  19.149 Info MultiplayerManager.cpp:1633: networkTick(17174061) mapTick(-1) adding mapAlignTask(SendPlayerJoinGameAlignTask)
  19.149 Info MultiplayerManager.cpp:1420: Received script checksums: level: 3679509607, mod-hardCrafting: 2917513214, mod-rocketAutoStarter: 3234395257, mod-rso-mod: 2870319608
  19.243 Info MultiplayerManager.cpp:1060: networkTick(17174067) mapTick(-1) received stateChanged peerID(51) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
 177.444 Finished download (158 s, 48 MB, 305 kB/s)
 177.721 Info MultiplayerManager.cpp:1135: networkTick(17179646) mapTick(-1) map download finished creating scenario
 177.721 Info MultiplayerManager.cpp:913: networkTick(17179646) mapTick(-1) changing state from(ConnectedDownloadingMap) to(ConnectedLoadingMap)
 177.721 Loading map C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip
 177.722 Info MultiplayerManager.cpp:1060: networkTick(17179652) mapTick(-1) received stateChanged peerID(51) oldState(ConnectedDownloadingMap) newState(ConnectedLoadingMap)
 177.751 Info Scenario.cpp:124: Map version 0.12.33-0
 178.028 Info MultiplayerManager.cpp:1060: networkTick(17179658) mapTick(-1) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
 186.795 Checksum for script C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/temp/currently-playing/control.lua: 3679509607
 186.802 Checksum for script __hardCrafting__/control.lua: 2917513214
 186.803 Checksum for script __rocketAutoStarter__/control.lua: 3234395257
 186.812 Checksum for script __rso-mod__/control.lua: 2870319608
 187.293 Info MultiplayerManager.cpp:913: networkTick(17180098) mapTick(69012791) changing state from(ConnectedLoadingMap) to(InGameWaitingForOthers)
 187.571 Info MultiplayerManager.cpp:1060: networkTick(17180104) mapTick(69012791) received stateChanged peerID(51) oldState(ConnectedLoadingMap) newState(InGameWaitingForOthers)
 187.571 Info MultiplayerManager.cpp:1259: networkTick(17180104) mapTick(69012791) stopping mapAlign
 187.571 Info MultiplayerManager.cpp:1785: performing map align task (SendPlayerJoinGameAlignTask)
 187.571 Info MultiplayerManager.cpp:913: networkTick(17180104) mapTick(69012791) changing state from(InGameWaitingForOthers) to(InGame)
 187.571 Info MultiplayerManager.cpp:1607: networkTick(17180104) mapTick(69012791) peerID(51) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(48) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(49) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(50) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(51) state(InGameWaitingForOthers) mapAlignTick(-1))
)
 187.807 Info MultiplayerManager.cpp:1060: networkTick(17180110) mapTick(69012792) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
 187.807 Info MultiplayerManager.cpp:1060: networkTick(17180110) mapTick(69012792) received stateChanged peerID(48) oldState(InGameWaitingForOthers) newState(InGame)
 187.807 Info MultiplayerManager.cpp:1060: networkTick(17180110) mapTick(69012792) received stateChanged peerID(49) oldState(InGameWaitingForOthers) newState(InGame)
 187.807 Info MultiplayerManager.cpp:1060: networkTick(17180110) mapTick(69012792) received stateChanged peerID(50) oldState(InGameWaitingForOthers) newState(InGame)
 187.807 Info MultiplayerManager.cpp:1060: networkTick(17180110) mapTick(69012792) received stateChanged peerID(51) oldState(InGameWaitingForOthers) newState(InGame)
 187.984 Info NetworkInputHandler.cpp:745: mapTick(69012800) networkTick(17180119) connecting to player(Loewchen).
 187.984 Info NetworkInputHandler.cpp:599: assigning playerIndex(13) to peer(51)
 187.984 Info GameActionHandler.cpp:1949: MapTick(69012800) processed PlayerJoinGame peerID(51) playerIndex(13) mode(connect)
 345.271 Error NetworkInputHandler.cpp:360: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(69016260) peer(51) testCrc(-92481759) testCrcPeerID(0) currentCrc(-2080071801)
 345.271 Info NetworkInputHandler.cpp:402: Desync specification: Reference CRC = 4202485537, reference peers = {0, 48 (kaZ), 49 (Smarty), 50 (Lotny)}; desynced CRC = 2214895495, desynced peer = 51 (Loewchen)
 345.271 Info MultiplayerManager.cpp:913: networkTick(17187839) mapTick(69016269) changing state from(InGame) to(Desynced)
 345.387 Info MultiplayerManager.cpp:1060: networkTick(17187845) mapTick(69016269) received stateChanged peerID(51) oldState(InGame) newState(Desynced)
 345.387 Info MultiplayerManager.cpp:913: networkTick(17187845) mapTick(69016269) changing state from(Desynced) to(DesyncedAligning)
 345.387 Info MultiplayerManager.cpp:1719: networkTick(17187845) mapTick(69016269) starting mapAlign
 345.487 Info MultiplayerManager.cpp:1060: networkTick(17187851) mapTick(69016269) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
 345.487 Info MultiplayerManager.cpp:1060: networkTick(17187851) mapTick(69016269) received stateChanged peerID(48) oldState(InGame) newState(InGameAligning)
 345.487 Info MultiplayerManager.cpp:1060: networkTick(17187851) mapTick(69016269) received stateChanged peerID(49) oldState(InGame) newState(InGameAligning)
 345.487 Info MultiplayerManager.cpp:1060: networkTick(17187851) mapTick(69016269) received stateChanged peerID(50) oldState(InGame) newState(InGameAligning)
 345.487 Info MultiplayerManager.cpp:1060: networkTick(17187851) mapTick(69016269) received stateChanged peerID(51) oldState(Desynced) newState(DesyncedAligning)
 345.487 Info MultiplayerManager.cpp:1653: networkTick(17187851) mapTick(69016269) sending mapAlignAction
 345.587 Info MultiplayerManager.cpp:1307: networkTick(17187857) mapTick(69016269) received MapAlignAction from peer(0), mapAlignTick(69016273) appliedTickClosuresCount(34)
 345.587 Info MultiplayerManager.cpp:1307: networkTick(17187857) mapTick(69016269) received MapAlignAction from peer(48), mapAlignTick(69016269) appliedTickClosuresCount(54)
 345.587 Info MultiplayerManager.cpp:1307: networkTick(17187857) mapTick(69016269) received MapAlignAction from peer(49), mapAlignTick(69016273) appliedTickClosuresCount(34)
 345.587 Info MultiplayerManager.cpp:1307: networkTick(17187857) mapTick(69016269) received MapAlignAction from peer(50), mapAlignTick(69016273) appliedTickClosuresCount(34)
 345.587 Info MultiplayerManager.cpp:1307: networkTick(17187857) mapTick(69016269) received MapAlignAction from peer(51), mapAlignTick(69016270) appliedTickClosuresCount(0)
 345.587 Info MultiplayerManager.cpp:1735: networkTick(17187858) mapTick(69016269) mapAlign finished targetTick(69016273) updating map and running the tasks ...
 345.587 Info MultiplayerManager.cpp:1607: networkTick(17187858) mapTick(69016269) peerID(51) fullStateLog: local state(DesyncedAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(69016273))
((peerID(48) state(InGameAligning) mapAlignTick(69016269))
((peerID(49) state(InGameAligning) mapAlignTick(69016273))
((peerID(50) state(InGameAligning) mapAlignTick(69016273))
((peerID(51) state(DesyncedAligning) mapAlignTick(69016270))
)
 345.681 Info MultiplayerManager.cpp:1754: maptick(69016273) crc before applying all ticks: 405730179
 345.681 Info NetworkInputHandler.cpp:661: applyAllTickClosures: expectedMapTick(69016273) lastTickApplied(69016264) referenceMapTick(69016273) networkTick(17187858)
 345.681 Info NetworkInputHandler.cpp:685: applyAllTickClosures: applying tickClosure(tick(69016267) inputActions((SelectedEntityChanged) ) ) for peer(48)
 345.681 Info NetworkInputHandler.cpp:685: applyAllTickClosures: applying tickClosure(tick(69016268) inputActions((SelectedEntityChanged) ) ) for peer(51)
 345.681 Info MultiplayerManager.cpp:1762: maptick(69016273) crc after applying all ticks: 405730179
 345.681 Info MultiplayerManager.cpp:913: networkTick(17187858) mapTick(69016273) changing state from(DesyncedAligning) to(DesyncedAligned)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(48) oldState(InGameAligning) newState(InGameAligned)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(48) oldState(InGameAligned) newState(InGameWaitingForOthers)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(49) oldState(InGameAligning) newState(InGameAligned)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(49) oldState(InGameAligned) newState(InGameWaitingForOthers)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(50) oldState(InGameAligning) newState(InGameAligned)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(50) oldState(InGameAligned) newState(InGameWaitingForOthers)
 345.901 Info MultiplayerManager.cpp:1060: networkTick(17187864) mapTick(69016273) received stateChanged peerID(51) oldState(DesyncedAligning) newState(DesyncedAligned)
 345.901 Info MultiplayerManager.cpp:1974: NetworkTick(17187864) reconnecting after map desync.
 345.901 Info MultiplayerManager.cpp:2121: NetworkTick(17187864) MapTick(69016273) disconnecting player(13) from the user.
 345.904 Info MultiplayerManager.cpp:913: networkTick(17187864) mapTick(69016273) changing state from(DesyncedAligned) to(DesyncedCreatingReport)
 346.000 Info MultiplayerManager.cpp:1060: networkTick(17187870) mapTick(69016273) received stateChanged peerID(51) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
 353.751 Info MultiplayerManager.cpp:913: networkTick(17188321) mapTick(-1) changing state from(DesyncedCreatingReport) to(DesyncedWaitingForMap)
 353.766 Info NetworkInputHandler.cpp:762: mapTick(69016273) networkTick(17188321) disconnecting from player.
 356.584 Info MultiplayerManager.cpp:1060: networkTick(17188327) mapTick(-1) received stateChanged peerID(51) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
 356.584 Info Synchronizer.cpp:444: NetworkTick(17188333) peer(0) drop detection state(100/900).
 356.584 Info Synchronizer.cpp:444: NetworkTick(17188333) peer(48) drop detection state(100/900).
 356.584 Info Synchronizer.cpp:444: NetworkTick(17188333) peer(49) drop detection state(100/900).
 356.584 Info Synchronizer.cpp:444: NetworkTick(17188333) peer(50) drop detection state(100/900).
 356.925 Info MultiplayerManager.cpp:1060: networkTick(17188333) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
 357.163 Info Synchronizer.cpp:444: NetworkTick(17188337) peer(50) drop detection state(100/900).
 363.997 Info MultiplayerManager.cpp:1060: networkTick(17188719) mapTick(-1) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
 363.997 Downloading file C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip (48250463 B, 39485 blocks)
 364.007 Info MultiplayerManager.cpp:913: networkTick(17188719) mapTick(-1) changing state from(DesyncedWaitingForMap) to(DesyncedDownloadingMap)
 364.007 Info NetworkInputHandler.cpp:45: mapTick(69016273) networkTick(17188719) initialized NetworkInputHandler local peer(51).
 364.007 Info NetworkInputHandler.cpp:520: expectedMapTick(69016273) adding peer(0).
 364.007 Info NetworkInputHandler.cpp:520: expectedMapTick(69016273) adding peer(48).
 364.007 Info NetworkInputHandler.cpp:520: expectedMapTick(69016273) adding peer(49).
 364.007 Info NetworkInputHandler.cpp:520: expectedMapTick(69016273) adding peer(50).
 364.007 Info Synchronizer.cpp:413: NetworkTick(17188719) mapTick(69016273) applying 35 pending tickClosures
 364.007 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(0)
 364.007 Info NetworkInputHandler.cpp:599: assigning playerIndex(2) to peer(48)
 364.007 Info NetworkInputHandler.cpp:599: assigning playerIndex(4) to peer(49)
 364.007 Info NetworkInputHandler.cpp:599: assigning playerIndex(99) to peer(50)
 364.007 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(51)
 364.007 Info MultiplayerManager.cpp:1633: networkTick(17188719) mapTick(-1) adding mapAlignTask(SendPlayerJoinGameAlignTask)
 364.099 Info MultiplayerManager.cpp:1060: networkTick(17188725) mapTick(-1) received stateChanged peerID(51) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
 502.451 Finished download (138 s, 48 MB, 348 kB/s)
 502.695 Info MultiplayerManager.cpp:1135: networkTick(17194991) mapTick(-1) map download finished creating scenario
 502.695 Info MultiplayerManager.cpp:913: networkTick(17194991) mapTick(-1) changing state from(DesyncedDownloadingMap) to(DesyncedLoadingMap)
 502.695 Loading map C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip
 502.696 Info MultiplayerManager.cpp:1060: networkTick(17194997) mapTick(-1) received stateChanged peerID(51) oldState(DesyncedDownloadingMap) newState(DesyncedLoadingMap)
 502.731 Info Scenario.cpp:124: Map version 0.12.33-0
 502.882 Info MultiplayerManager.cpp:1060: networkTick(17195003) mapTick(-1) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
 511.571 Checksum for script C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/temp/currently-playing/control.lua: 3679509607
 511.576 Checksum for script __hardCrafting__/control.lua: 2917513214
 511.578 Checksum for script __rocketAutoStarter__/control.lua: 3234395257
 511.587 Checksum for script __rso-mod__/control.lua: 2870319608
From the log of the reconnect (third desync that I participated)

Code: Select all

   0.001 2016-06-05 00:18:05; Factorio 0.12.33 (Build 18092, win64, alpha)
   0.002 Operating system: Windows 7 Service Pack 1
   0.002 Program arguments: "C:\Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\bin\x64\Factorio.exe" 
   0.002 Read data path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/data
   0.002 Write data path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting
   0.002 Binaries path: C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/bin
   0.023 Graphics options: [FullScreen: true] [VSync: true] [UIScale: 95%] [MultiSampling: OFF] [Graphics quality: low] [Video memory usage: all] [Light scale: 20%] [Screen: 255]
   0.023 Available display adapters: 1
   0.023  [0]: \\.\DISPLAY1 - NVIDIA GeForce GTX 560 Ti   {0x05, [0,0], 1920x1080, 32bit, 60Hz}
   0.024 Create display on adapter 0. Size 1280x720 at position [310, 162].
   0.484 Initialised Direct3D:[0] NVIDIA GeForce GTX 560 Ti  ; driver: nvd3dumx.dll 9.18.13.4052
   0.538 Desktop composition is active.
   0.590 Loading mod core 0.0.0 (data.lua)
   0.594 Loading mod base 0.12.33 (data.lua)
   0.669 Loading mod air-filtering 0.3.2 (data.lua)
   0.711 Loading mod hardCrafting 0.3.14 (data.lua)
   0.768 Loading mod Larger Inventory 1.0.0 (data.lua)
   0.812 Loading mod rocketAutoStarter 0.1.0 (data.lua)
   0.858 Loading mod hardCrafting 0.3.14 (data-updates.lua)
   0.910 Loading mod rso-mod 1.5.6 (data-updates.lua)
   0.952 Loading mod hardCrafting 0.3.14 (data-final-fixes.lua)
   1.007 Checksum for core: 3711505753
   1.007 Checksum for mod base: 2829195351
   1.007 Checksum for mod air-filtering: 1717915892
   1.007 Checksum for mod hardCrafting: 3423309532
   1.007 Checksum for mod Larger Inventory: 32563986
   1.007 Checksum for mod rocketAutoStarter: 2195749245
   1.007 Checksum for mod rso-mod: 4065594479
   1.456 Initial atlas bitmap size is 16384
   1.458 Created atlas bitmap 16384x3509
   6.134 Sprites loaded
   6.191 Loading sounds...
   7.638 Factorio initialised
  11.026 Info Router.cpp:509: Router peerID(65535) shutting down.
  11.042 Info Router.cpp:536: Router state -> Disconnected
  11.042 Joining game 176.31.245.226:34198 at port 34197
  11.042 Info WindowsUDPSocket.cpp:73: Opening socket at port (34197)
  11.048 Info Router.cpp:536: Router state -> Connecting
  11.049 Info MultiplayerManager.cpp:913: networkTick(0) mapTick(-1) changing state from(Ready) to(Connecting)
  11.143 Info Router.cpp:536: Router state -> WaitingForAccept
  11.227 Info Synchronizer.cpp:54: NetworkTick(17214572) initialized Synchronizer local peer(52) latency(6).
  11.227 Info Synchronizer.cpp:500: networkTick(17214572) adding peer(0) success(true).
  11.227 Info Synchronizer.cpp:500: networkTick(17214572) adding peer(48) success(true).
  11.227 Info Synchronizer.cpp:500: networkTick(17214572) adding peer(49) success(true).
  11.227 Info Synchronizer.cpp:500: networkTick(17214572) adding peer(50) success(true).
  11.227 Info Router.cpp:536: Router state -> Connected
  11.227 Info Router.cpp:729: ConnectionAccepted ownPeerID(52) nextPeerID(53)
  11.227 Info MultiplayerManager.cpp:913: networkTick(17214572) mapTick(-1) changing state from(Connecting) to(VerifyingConnection)
  11.293 Info Router.cpp:741: Received onPeerConnected for already connected peer(52)
  11.393 Info MultiplayerManager.cpp:1433: Received peer info for peer(0) username(<server>).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(0) oldState(Ready) newState(InGame)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(48) username(kaZ).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(48) oldState(Ready) newState(InGame)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(49) username(Smarty).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(49) oldState(Ready) newState(InGame)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(50) username(Lotny).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(50) oldState(Ready) newState(InGame)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(52) username(Loewchen).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Ready) newState(Connecting)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(52) username(Loewchen).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Connecting) newState(Connecting)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(52) username(Loewchen).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Connecting) newState(Connecting)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(52) username(Loewchen).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Connecting) newState(Connecting)
  11.394 Info MultiplayerManager.cpp:1433: Received peer info for peer(52) username(Loewchen).
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Connecting) newState(Connecting)
  11.394 Info MultiplayerManager.cpp:1060: networkTick(17214578) mapTick(-1) received stateChanged peerID(52) oldState(Connecting) newState(VerifyingConnection)
  11.628 Info MultiplayerManager.cpp:913: networkTick(17214585) mapTick(-1) changing state from(VerifyingConnection) to(ConnectedWaitingForMap)
  11.727 Info MultiplayerManager.cpp:1060: networkTick(17214591) mapTick(-1) received stateChanged peerID(52) oldState(VerifyingConnection) newState(ConnectedWaitingForMap)
  11.843 Info MultiplayerManager.cpp:1060: networkTick(17214597) mapTick(-1) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  11.843 Info MultiplayerManager.cpp:1060: networkTick(17214597) mapTick(-1) received stateChanged peerID(48) oldState(InGame) newState(InGameAligning)
  11.843 Info MultiplayerManager.cpp:1060: networkTick(17214597) mapTick(-1) received stateChanged peerID(49) oldState(InGame) newState(InGameAligning)
  11.843 Info MultiplayerManager.cpp:1060: networkTick(17214597) mapTick(-1) received stateChanged peerID(50) oldState(InGame) newState(InGameAligning)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(48) oldState(InGameAligning) newState(InGameAligned)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(48) oldState(InGameAligned) newState(InGameWaitingForOthers)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(49) oldState(InGameAligning) newState(InGameAligned)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(49) oldState(InGameAligned) newState(InGameWaitingForOthers)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(50) oldState(InGameAligning) newState(InGameAligned)
  12.160 Info MultiplayerManager.cpp:1060: networkTick(17214610) mapTick(-1) received stateChanged peerID(50) oldState(InGameAligned) newState(InGameWaitingForOthers)
  19.176 Info MultiplayerManager.cpp:1060: networkTick(17215025) mapTick(-1) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  19.177 Downloading file C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip (48068509 B, 39336 blocks)
  19.182 Info MultiplayerManager.cpp:913: networkTick(17215025) mapTick(-1) changing state from(ConnectedWaitingForMap) to(ConnectedDownloadingMap)
  19.182 Info NetworkInputHandler.cpp:45: mapTick(69023675) networkTick(17215025) initialized NetworkInputHandler local peer(52).
  19.182 Info NetworkInputHandler.cpp:520: expectedMapTick(69023675) adding peer(0).
  19.182 Info NetworkInputHandler.cpp:520: expectedMapTick(69023675) adding peer(48).
  19.182 Info NetworkInputHandler.cpp:520: expectedMapTick(69023675) adding peer(49).
  19.182 Info NetworkInputHandler.cpp:520: expectedMapTick(69023675) adding peer(50).
  19.182 Info Synchronizer.cpp:413: NetworkTick(17215025) mapTick(69023675) applying 32 pending tickClosures
  19.182 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(0)
  19.182 Info NetworkInputHandler.cpp:599: assigning playerIndex(2) to peer(48)
  19.182 Info NetworkInputHandler.cpp:599: assigning playerIndex(4) to peer(49)
  19.182 Info NetworkInputHandler.cpp:599: assigning playerIndex(99) to peer(50)
  19.182 Info NetworkInputHandler.cpp:599: assigning playerIndex(65535) to peer(52)
  19.182 Info MultiplayerManager.cpp:1633: networkTick(17215025) mapTick(-1) adding mapAlignTask(SendPlayerJoinGameAlignTask)
  19.183 Info MultiplayerManager.cpp:1420: Received script checksums: level: 3679509607, mod-hardCrafting: 2917513214, mod-rocketAutoStarter: 3234395257, mod-rso-mod: 2870319608
  19.277 Info MultiplayerManager.cpp:1060: networkTick(17215031) mapTick(-1) received stateChanged peerID(52) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
 172.361 Finished download (153 s, 48 MB, 314 kB/s)
 172.609 Info MultiplayerManager.cpp:1135: networkTick(17221350) mapTick(-1) map download finished creating scenario
 172.610 Info MultiplayerManager.cpp:913: networkTick(17221350) mapTick(-1) changing state from(ConnectedDownloadingMap) to(ConnectedLoadingMap)
 172.610 Loading map C:/Spiele\Factorio\Factorio_0.12.33_daniel_hardcrafting\temp\mp-download.zip
 172.611 Info MultiplayerManager.cpp:1060: networkTick(17221356) mapTick(-1) received stateChanged peerID(52) oldState(ConnectedDownloadingMap) newState(ConnectedLoadingMap)
 172.640 Info Scenario.cpp:124: Map version 0.12.33-0
 172.813 Info MultiplayerManager.cpp:1060: networkTick(17221362) mapTick(-1) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
 181.476 Checksum for script C:/Spiele/Factorio/Factorio_0.12.33_daniel_hardcrafting/temp/currently-playing/control.lua: 3679509607
 181.481 Checksum for script __hardCrafting__/control.lua: 2917513214
 181.482 Checksum for script __rocketAutoStarter__/control.lua: 3234395257
 181.492 Checksum for script __rso-mod__/control.lua: 2870319608
 181.987 Info MultiplayerManager.cpp:913: networkTick(17221850) mapTick(69023675) changing state from(ConnectedLoadingMap) to(InGameWaitingForOthers)
 182.887 Info MultiplayerManager.cpp:1060: networkTick(17221856) mapTick(69023675) received stateChanged peerID(52) oldState(ConnectedLoadingMap) newState(InGameWaitingForOthers)
 182.888 Info MultiplayerManager.cpp:1259: networkTick(17221856) mapTick(69023675) stopping mapAlign
 182.888 Info MultiplayerManager.cpp:1785: performing map align task (SendPlayerJoinGameAlignTask)
 182.888 Info MultiplayerManager.cpp:913: networkTick(17221856) mapTick(69023675) changing state from(InGameWaitingForOthers) to(InGame)
 182.888 Info MultiplayerManager.cpp:1607: networkTick(17221856) mapTick(69023675) peerID(52) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(48) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(49) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(50) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(52) state(InGameWaitingForOthers) mapAlignTick(-1))
)
 183.229 Info MultiplayerManager.cpp:1060: networkTick(17221862) mapTick(69023681) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
 183.229 Info MultiplayerManager.cpp:1060: networkTick(17221862) mapTick(69023681) received stateChanged peerID(48) oldState(InGameWaitingForOthers) newState(InGame)
 183.229 Info MultiplayerManager.cpp:1060: networkTick(17221862) mapTick(69023681) received stateChanged peerID(49) oldState(InGameWaitingForOthers) newState(InGame)
 183.229 Info MultiplayerManager.cpp:1060: networkTick(17221862) mapTick(69023681) received stateChanged peerID(50) oldState(InGameWaitingForOthers) newState(InGame)
 183.229 Info MultiplayerManager.cpp:1060: networkTick(17221862) mapTick(69023681) received stateChanged peerID(52) oldState(InGameWaitingForOthers) newState(InGame)
 183.296 Info NetworkInputHandler.cpp:745: mapTick(69023684) networkTick(17221865) connecting to player(Loewchen).
 183.296 Info NetworkInputHandler.cpp:599: assigning playerIndex(13) to peer(52)
 183.296 Info GameActionHandler.cpp:1949: MapTick(69023684) processed PlayerJoinGame peerID(52) playerIndex(13) mode(connect)
 185.016 Error NetworkInputHandler.cpp:360: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(69023700) peer(48) testCrc(-1934878467) testCrcPeerID(0) currentCrc(-2033222254)
 185.017 Info NetworkInputHandler.cpp:402: Desync specification: Reference CRC = 2261745042, reference peers = {48 (kaZ), 49 (Smarty), 50 (Lotny)}; desynced CRC = 2360088829, desynced peer = 0desynced CRC = 2360088829, desynced peer = 52 (Loewchen)
 185.017 Error NetworkInputHandler.cpp:360: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(69023700) peer(49) testCrc(-1934878467) testCrcPeerID(0) currentCrc(-2033222254)
 185.017 Info NetworkInputHandler.cpp:402: Desync specification: Reference CRC = 2261745042, reference peers = {48 (kaZ), 49 (Smarty), 50 (Lotny)}; desynced CRC = 2360088829, desynced peer = 0desynced CRC = 2360088829, desynced peer = 52 (Loewchen)
 185.017 Error NetworkInputHandler.cpp:360: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(69023700) peer(50) testCrc(-1934878467) testCrcPeerID(0) currentCrc(-2033222254)
 185.017 Info NetworkInputHandler.cpp:402: Desync specification: Reference CRC = 2261745042, reference peers = {48 (kaZ), 49 (Smarty), 50 (Lotny)}; desynced CRC = 2360088829, desynced peer = 0desynced CRC = 2360088829, desynced peer = 52 (Loewchen)
 185.017 Info MultiplayerManager.cpp:913: networkTick(17221901) mapTick(69023709) changing state from(InGame) to(Desynced)
 185.235 Info MultiplayerManager.cpp:1060: networkTick(17221907) mapTick(69023709) received stateChanged peerID(52) oldState(InGame) newState(Desynced)
 185.235 Info MultiplayerManager.cpp:913: networkTick(17221907) mapTick(69023709) changing state from(Desynced) to(DesyncedAligning)
 185.235 Info MultiplayerManager.cpp:1719: networkTick(17221907) mapTick(69023709) starting mapAlign
 185.335 Info MultiplayerManager.cpp:1060: networkTick(17221913) mapTick(69023709) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
 185.335 Info MultiplayerManager.cpp:1060: networkTick(17221913) mapTick(69023709) received stateChanged peerID(48) oldState(InGame) newState(InGameAligning)
 185.335 Info MultiplayerManager.cpp:1060: networkTick(17221913) mapTick(69023709) received stateChanged peerID(49) oldState(InGame) newState(InGameAligning)
 185.335 Info MultiplayerManager.cpp:1060: networkTick(17221913) mapTick(69023709) received stateChanged peerID(50) oldState(InGame) newState(InGameAligning)
 185.335 Info MultiplayerManager.cpp:1060: networkTick(17221913) mapTick(69023709) received stateChanged peerID(52) oldState(Desynced) newState(DesyncedAligning)
 185.335 Info MultiplayerManager.cpp:1653: networkTick(17221913) mapTick(69023709) sending mapAlignAction
 185.435 Info MultiplayerManager.cpp:1307: networkTick(17221919) mapTick(69023709) received MapAlignAction from peer(0), mapAlignTick(69023717) appliedTickClosuresCount(28)
 185.435 Info MultiplayerManager.cpp:1307: networkTick(17221919) mapTick(69023709) received MapAlignAction from peer(48), mapAlignTick(69023712) appliedTickClosuresCount(53)
 185.435 Info MultiplayerManager.cpp:1307: networkTick(17221919) mapTick(69023709) received MapAlignAction from peer(49), mapAlignTick(69023716) appliedTickClosuresCount(33)
 185.435 Info MultiplayerManager.cpp:1307: networkTick(17221919) mapTick(69023709) received MapAlignAction from peer(50), mapAlignTick(69023717) appliedTickClosuresCount(28)
 185.435 Info MultiplayerManager.cpp:1307: networkTick(17221919) mapTick(69023709) received MapAlignAction from peer(52), mapAlignTick(69023710) appliedTickClosuresCount(0)
 185.436 Info MultiplayerManager.cpp:1735: networkTick(17221920) mapTick(69023709) mapAlign finished targetTick(69023717) updating map and running the tasks ...
 185.436 Info MultiplayerManager.cpp:1607: networkTick(17221920) mapTick(69023709) peerID(52) fullStateLog: local state(DesyncedAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(69023717))
((peerID(48) state(InGameAligning) mapAlignTick(69023712))
((peerID(49) state(InGameAligning) mapAlignTick(69023716))
((peerID(50) state(InGameAligning) mapAlignTick(69023717))
((peerID(52) state(DesyncedAligning) mapAlignTick(69023710))
)
 185.621 Info MultiplayerManager.cpp:1754: maptick(69023717) crc before applying all ticks: 534434814
 185.621 Info NetworkInputHandler.cpp:661: applyAllTickClosures: expectedMapTick(69023717) lastTickApplied(69023708) referenceMapTick(69023717) networkTick(17221920)
 185.621 Info MultiplayerManager.cpp:1762: maptick(69023717) crc after applying all ticks: 534434814
 185.621 Info MultiplayerManager.cpp:913: networkTick(17221920) mapTick(69023717) changing state from(DesyncedAligning) to(DesyncedAligned)
 185.805 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
 185.805 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(48) oldState(InGameAligning) newState(InGameAligned)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(48) oldState(InGameAligned) newState(InGameWaitingForOthers)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(49) oldState(InGameAligning) newState(InGameAligned)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(49) oldState(InGameAligned) newState(InGameWaitingForOthers)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(50) oldState(InGameAligning) newState(InGameAligned)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(50) oldState(InGameAligned) newState(InGameWaitingForOthers)
 185.806 Info MultiplayerManager.cpp:1060: networkTick(17221926) mapTick(69023717) received stateChanged peerID(52) oldState(DesyncedAligning) newState(DesyncedAligned)
 185.806 Info MultiplayerManager.cpp:1974: NetworkTick(17221926) reconnecting after map desync.
 185.806 Info MultiplayerManager.cpp:2121: NetworkTick(17221926) MapTick(69023717) disconnecting player(13) from the user.
 185.809 Info MultiplayerManager.cpp:913: networkTick(17221926) mapTick(69023717) changing state from(DesyncedAligned) to(DesyncedCreatingReport)
 185.906 Info MultiplayerManager.cpp:1060: networkTick(17221932) mapTick(69023717) received stateChanged peerID(52) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
 188.571 Info MultiplayerManager.cpp:134: NetworkTick(17222080) disconnecting multiplayer connection.
 188.571 Info NetworkInputHandler.cpp:64: expectedMapTick(69023717) sending PlayerLeaveGame
 188.776 Info MultiplayerManager.cpp:1477: Disconnect notification for peer (52)
 188.776 Info MultiplayerManager.cpp:1010: networkTick(17222086) mapTick(69023717) removing peer(52) dropout(false)
 188.776 Info MultiplayerManager.cpp:1633: networkTick(17222086) mapTick(69023717) adding mapAlignTask(RemovePlayerAlignTask)
 193.559 Info MultiplayerManager.cpp:913: networkTick(17222342) mapTick(-1) changing state from(DesyncedCreatingReport) to(DesyncedWaitingForMap)
 193.560 Info NetworkInputHandler.cpp:762: mapTick(69023717) networkTick(17222342) disconnecting from player.
 194.976 Info MultiplayerManager.cpp:1060: networkTick(17222348) mapTick(-1) received stateChanged peerID(52) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
 195.259 Info MultiplayerManager.cpp:1060: networkTick(17222354) mapTick(-1) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
As reference: The desync at 185s is the one @ 293775s in daniels log.
Rseding91
Factorio Staff
Factorio Staff
Posts: 14308
Joined: Wed Jun 11, 2014 5:23 am
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Rseding91 »

Can you please zip and upload the entire mod folder?
If you want to get ahold of me I'm almost always on Discord.
Loewchen
Global Moderator
Global Moderator
Posts: 9236
Joined: Wed Jan 07, 2015 5:53 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Loewchen »

Rseding91 wrote:Can you please zip and upload the entire mod folder?
http://188.165.250.160:34197/mods.zip
Rseding91
Factorio Staff
Factorio Staff
Posts: 14308
Joined: Wed Jun 11, 2014 5:23 am
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Rseding91 »

I don't have any way to verify it but the only suspect mod in that list would be the hardCrafting one. It's the only mod that does actions on a 60 tick cycle, has at least one instance where it could try to divide by 0, and is setup to do things on_load that it should never be trying to do (adjusts global, runs stuff on the next tick after loading).
If you want to get ahold of me I'm almost always on Discord.
Loewchen
Global Moderator
Global Moderator
Posts: 9236
Joined: Wed Jan 07, 2015 5:53 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Loewchen »

More interesting than what causes the desync is, how it is possible that there is no consensus about who is desynced and who is reference, I could not imagine this being caused by mods.

Edit: Could this fix be causing this?
viewtopic.php?f=11&t=22206&p=142914
kovarex wrote:The server actually got desynced, and then he had no one to download from, we solved it for 0.12.30, by forcing the server to never be the one who desyncs even if there are more players with different crc.
User avatar
Klonan
Factorio Staff
Factorio Staff
Posts: 5274
Joined: Sun Jan 11, 2015 2:09 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Klonan »

Loewchen wrote:More interesting than what causes the desync is, how it is possible that there is no consensus about who is desynced and who is reference, I could not imagine this being caused by mods.

Edit: Could this fix be causing this?
viewtopic.php?f=11&t=22206&p=142914
kovarex wrote:The server actually got desynced, and then he had no one to download from, we solved it for 0.12.30, by forcing the server to never be the one who desyncs even if there are more players with different crc.

Can you reproduce the desync, does this happen without mods?
Muchaszewski
Inserter
Inserter
Posts: 24
Joined: Wed Nov 13, 2013 11:17 am
Contact:

Re: [0.12.33] [Pending]desync every 60 ticks - no map redownload

Post by Muchaszewski »

It looks like this was caused by hardCraft mod item called "belt sorter". Timespan was right, issues happend when i placed it, accesed and remove it.

There is a posibility that if you will make a mistake in code, this issue will go out again in the same form, but This isn't something you should concern right now, or never. Since .13 has some core changes in multiplayer, but would be nice if server would try to sync with players from time to time :P Or inform that to players somehow, that server has diffrent game state then player(s) do.
In game Lotny
Loewchen
Global Moderator
Global Moderator
Posts: 9236
Joined: Wed Jan 07, 2015 5:53 pm
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Loewchen »

Klonan wrote:Can you reproduce the desync, does this happen without mods?
I assure you we would never withhold steps to reproduce a desync, if we knew them :P
Just to make it clear once more, this report is not about the desync itself, we don't make reports of the desyncs on the moded server any more. This report is about how nonsensically the server reacted to it.

Greetings Loewchen
Oxyd
Former Staff
Former Staff
Posts: 1428
Joined: Thu May 07, 2015 8:42 am
Contact:

Re: [0.12.33] desync every 60 ticks - no map redownload

Post by Oxyd »

Loewchen wrote:More interesting than what causes the desync is, how it is possible that there is no consensus about who is desynced and who is reference, I could not imagine this being caused by mods.

Edit: Could this fix be causing this?
viewtopic.php?f=11&t=22206&p=142914
kovarex wrote:The server actually got desynced, and then he had no one to download from, we solved it for 0.12.30, by forcing the server to never be the one who desyncs even if there are more players with different crc.
I think this has been fixed in 0.13.0 already. That should solve the issue with no map redownload as well. Moving to resolved.
Post Reply

Return to “Resolved Problems and Bugs”