[0.13.1][Pending] Reliable desync on server join

Bugs that we were not able to reproduce, and/or are waiting for more detailed info.
Jerub
Burner Inserter
Burner Inserter
Posts: 7
Joined: Mon Jun 27, 2016 8:19 pm
Contact:

[0.13.1][Pending] Reliable desync on server join

Post by Jerub »

I have a reproducable reliable desync, using the headless server on our save game (imported from 0.12.35, used on 0.13.0, and now launching on 0.13.1).

We would see desyncs in a continuous loop for 5-10 minutes on first join, until it finally let a player on the game.

There are no mods in use.

Here is a log of what it looks like on the server side.

Code: Select all

   0.000 2016-06-30 09:15:22; Factorio 0.13.1 (Build 22864, linux64, headless)
   0.000 Operating system: Linux
   0.000 Not rotating logs.
   0.000 Program arguments: "/opt/factorio/bin/x64/factorio" "--latency-ms" "100" "--autosave-interval" "2" "--autosave-slots" "100" "--start-server" "/opt/factorio/saves/save.zip" 
   0.000 Read data path: /opt/factorio/data
   0.000 Write data path: /opt/factorio
   0.000 Binaries path: /opt/factorio/bin
   0.010 Running in headless mode
   0.012 Loading mod core 0.0.0 (data.lua)
   0.016 Loading mod base 0.13.1 (data.lua)
   0.115 Checksum for core: 1399339455
   0.115 Checksum for mod base: 2679425721
   0.492 Custom inputs active: 0
   0.493 Factorio initialised
   0.494 Info Router.cpp:563: Router peerID(65535) shutting down.
   0.494 Info Router.cpp:594: Router state -> Disconnected
   0.576 Info MultiplayerManager.cpp:996: networkTick(0) mapTick(-1) changing state from(Ready) to(PreparedToHostGame)
   0.576 Info MultiplayerManager.cpp:996: networkTick(0) mapTick(-1) changing state from(PreparedToHostGame) to(CreatingGame)
   0.577 Loading map /opt/factorio/saves/save.zip
   0.593 Info Scenario.cpp:129: Map version 0.13.0-93
   2.563 Applying migration: Base Mod: 2016-06-28_Factorio_0.13.0.lua
   2.572 Checksum for script /opt/factorio/temp/currently-playing/control.lua: 900459546
   2.670 Info PosixUDPSocket.cpp:50: Opening socket at port 34197
   2.670 Info Router.cpp:594: Router state -> Connected
   2.670 Info Synchronizer.cpp:56: NetworkTick(0) initialized Synchronizer local peer(0) latency(6).
   2.670 Hosting game at port 34197, peerID 0, session magic 1720
   2.670 Info MultiplayerManager.cpp:996: networkTick(0) mapTick(22780801) changing state from(CreatingGame) to(InGame)
   2.670 Info NetworkInputHandler.cpp:45: mapTick(22780801) networkTick(0) initialized NetworkInputHandler local peer(0).
   2.787 Info MultiplayerManager.cpp:1527: Received peer info for peer(0) username(<server>).
   2.787 Info MultiplayerManager.cpp:1143: networkTick(6) mapTick(22780801) received stateChanged peerID(0) oldState(Ready) newState(CreatingGame)
   2.787 Info MultiplayerManager.cpp:1143: networkTick(6) mapTick(22780801) received stateChanged peerID(0) oldState(CreatingGame) newState(InGame)
  20.898 Connection request(type(ConnectionRequest) applicationVersion(0.13.1 (Build 22864, linux64, headless)) activeMods((base 0.13.1) ) hasPassword(no) connectionRequestID(51719)) from(10.48.0.1:55261)
  20.898 Info Router.cpp:683: NetworkTick(1089) replying to connectionRequest for address(10.48.0.1:55261).
  21.030 Info Router.cpp:905: networkTick(1095) adding peer(1) address(10.48.0.1:55261) sending connectionAccept(true)
  21.030 Info Router.cpp:717: networkTick(1095) sending connectionAccept to address(10.48.0.1:55261) connectionRequestID(51719) newPeerID(1)
  21.030 Info Synchronizer.cpp:522: networkTick(1095) adding peer(1) success(true).
  21.545 Info MultiplayerManager.cpp:1527: Received peer info for peer(0) username(<server>).
  21.545 Info MultiplayerManager.cpp:1143: networkTick(1101) mapTick(22780809) received stateChanged peerID(0) oldState(InGame) newState(InGame)
  21.545 Info MultiplayerManager.cpp:1527: Received peer info for peer(1) username(IsoSchiz).
  21.545 Info MultiplayerManager.cpp:1143: networkTick(1101) mapTick(22780809) received stateChanged peerID(1) oldState(Ready) newState(Connecting)
  21.545 Info NetworkInputHandler.cpp:524: expectedMapTick(22780809) adding peer(1).
  21.545 Info MultiplayerManager.cpp:1527: Received peer info for peer(1) username(IsoSchiz).
  21.545 Info MultiplayerManager.cpp:1143: networkTick(1101) mapTick(22780809) received stateChanged peerID(1) oldState(Connecting) newState(Connecting)
  21.546 Info MultiplayerManager.cpp:1143: networkTick(1101) mapTick(22780809) received stateChanged peerID(1) oldState(Connecting) newState(VerifyingConnection)
  21.734 Info MultiplayerManager.cpp:1143: networkTick(1114) mapTick(22780810) received stateChanged peerID(1) oldState(VerifyingConnection) newState(ConnectedWaitingForMap)
  21.734 Info MultiplayerManager.cpp:996: networkTick(1114) mapTick(22780810) changing state from(InGame) to(InGameAligning)
  21.734 Info MultiplayerManager.cpp:1818: networkTick(1114) mapTick(22780810) starting mapAlign
  21.892 Info MultiplayerManager.cpp:1143: networkTick(1120) mapTick(22780810) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  21.892 Info MultiplayerManager.cpp:1752: networkTick(1120) mapTick(22780810) sending mapAlignAction
  22.005 Info MultiplayerManager.cpp:1390: networkTick(1126) mapTick(22780810) received MapAlignAction from peer(0), mapAlignTick(22780811) appliedTickClosuresCount(0)
  22.005 Info MultiplayerManager.cpp:1834: networkTick(1127) mapTick(22780810) mapAlign finished targetTick(22780811) updating map and running the tasks ...
  22.005 Info MultiplayerManager.cpp:1706: networkTick(1127) mapTick(22780810) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780811))
((peerID(1) state(ConnectedWaitingForMap) mapAlignTick(-1))
)
  22.011 Info MultiplayerManager.cpp:1853: maptick(22780811) crc before applying all ticks: 2004588791
  22.011 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780811) lastTickApplied(22780802) referenceMapTick(22780811) networkTick(1127)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780803) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780804) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780805) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780806) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780807) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780808) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780809) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  22.011 Info MultiplayerManager.cpp:1861: maptick(22780811) crc after applying all ticks: 2004588791
  22.011 Info MultiplayerManager.cpp:996: networkTick(1127) mapTick(22780811) changing state from(InGameAligning) to(InGameAligned)
  22.012 Info MultiplayerManager.cpp:996: networkTick(1127) mapTick(22780811) changing state from(InGameAligned) to(InGameSavingMap)
  22.272 Info MultiplayerManager.cpp:1143: networkTick(1133) mapTick(22780811) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  22.272 Info MultiplayerManager.cpp:1143: networkTick(1133) mapTick(22780811) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  23.332 Info MultiplayerManager.cpp:996: networkTick(1157) mapTick(22780811) changing state from(InGameSavingMap) to(InGameSendingMap)
  23.385 Info MultiplayerManager.cpp:1260: MapTick(22780811) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16407571) crc(71721498)
  23.385 Info MultiplayerManager.cpp:1143: networkTick(1163) mapTick(22780811) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  23.801 Info MultiplayerManager.cpp:1143: networkTick(1169) mapTick(22780811) received stateChanged peerID(1) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
  40.354 Info MultiplayerManager.cpp:1143: networkTick(1624) mapTick(22780811) received stateChanged peerID(1) oldState(ConnectedDownloadingMap) newState(ConnectedLoadingMap)
  40.354 Canceling serving for peer 1
  40.355 Info MultiplayerManager.cpp:996: networkTick(1624) mapTick(22780811) changing state from(InGameSendingMap) to(InGameWaitingForOthers)
  40.355 Info MultiplayerManager.cpp:1143: networkTick(1630) mapTick(22780811) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
  42.045 Info MultiplayerManager.cpp:1143: networkTick(1687) mapTick(22780811) received stateChanged peerID(1) oldState(ConnectedLoadingMap) newState(InGameWaitingForOthers)
  42.045 Info MultiplayerManager.cpp:1342: networkTick(1687) mapTick(22780811) stopping mapAlign
  42.045 Info MultiplayerManager.cpp:996: networkTick(1687) mapTick(22780811) changing state from(InGameWaitingForOthers) to(InGame)
  42.045 Info MultiplayerManager.cpp:1706: networkTick(1687) mapTick(22780811) peerID(0) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(1) state(InGameWaitingForOthers) mapAlignTick(-1))
)
  42.046 Info MultiplayerManager.cpp:1143: networkTick(1693) mapTick(22780811) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
  42.046 Info MultiplayerManager.cpp:1143: networkTick(1693) mapTick(22780811) received stateChanged peerID(1) oldState(InGameWaitingForOthers) newState(InGame)
  42.356 Info NetworkInputHandler.cpp:608: assigning playerIndex(1) to peer(1)
  42.356 Info GameActionHandler.cpp:2611: MapTick(22780820) processed PlayerJoinGame peerID(1) playerIndex(1) mode(connect)
  42.363 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780812) peer(1) testCrc(693642384) testCrcPeerID(0) currentCrc(-147287803)
  42.363 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 693642384, reference peers = {0}, desynced group = {CRC = 4147679493, peers = {1 (IsoSchiz)}}
  42.369 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780813) peer(1) testCrc(1799719226) testCrcPeerID(0) currentCrc(-1008375630)
  42.370 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 1799719226, reference peers = {0}, desynced group = {CRC = 3286591666, peers = {1 (IsoSchiz)}}
  42.376 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780814) peer(1) testCrc(-1544287112) testCrcPeerID(0) currentCrc(-2122021685)
  42.377 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2750680184, reference peers = {0}, desynced group = {CRC = 2172945611, peers = {1 (IsoSchiz)}}
  42.385 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780815) peer(1) testCrc(-1546457840) testCrcPeerID(0) currentCrc(-2126329399)
  42.385 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2748509456, reference peers = {0}, desynced group = {CRC = 2168637897, peers = {1 (IsoSchiz)}}
  42.391 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780816) peer(1) testCrc(-9296801) testCrcPeerID(0) currentCrc(699043185)
  42.392 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 4285670495, reference peers = {0}, desynced group = {CRC = 699043185, peers = {1 (IsoSchiz)}}
  42.398 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780817) peer(1) testCrc(-1499715173) testCrcPeerID(0) currentCrc(605352049)
  42.398 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2795252123, reference peers = {0}, desynced group = {CRC = 605352049, peers = {1 (IsoSchiz)}}
  42.404 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780818) peer(1) testCrc(1012465975) testCrcPeerID(0) currentCrc(-1760884958)
  42.404 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 1012465975, reference peers = {0}, desynced group = {CRC = 2534082338, peers = {1 (IsoSchiz)}}
  42.405 Info MultiplayerManager.cpp:1143: networkTick(1716) mapTick(22780827) received stateChanged peerID(1) oldState(InGame) newState(Desynced)
  42.405 Info MultiplayerManager.cpp:996: networkTick(1716) mapTick(22780827) changing state from(InGame) to(InGameAligning)
  42.405 Info MultiplayerManager.cpp:1818: networkTick(1716) mapTick(22780827) starting mapAlign
  42.595 Info MultiplayerManager.cpp:1143: networkTick(1722) mapTick(22780827) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  42.595 Info MultiplayerManager.cpp:1143: networkTick(1722) mapTick(22780827) received stateChanged peerID(1) oldState(Desynced) newState(DesyncedAligning)
  42.595 Info MultiplayerManager.cpp:1752: networkTick(1722) mapTick(22780827) sending mapAlignAction
  42.644 Info MultiplayerManager.cpp:1390: networkTick(1728) mapTick(22780827) received MapAlignAction from peer(0), mapAlignTick(22780828) appliedTickClosuresCount(0)
  42.644 Info MultiplayerManager.cpp:1390: networkTick(1728) mapTick(22780827) received MapAlignAction from peer(1), mapAlignTick(22780822) appliedTickClosuresCount(23)
  42.644 Info MultiplayerManager.cpp:1834: networkTick(1729) mapTick(22780827) mapAlign finished targetTick(22780828) updating map and running the tasks ...
  42.644 Info MultiplayerManager.cpp:1706: networkTick(1729) mapTick(22780827) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780828))
((peerID(1) state(DesyncedAligning) mapAlignTick(22780822))
)
  42.651 Info MultiplayerManager.cpp:1853: maptick(22780828) crc before applying all ticks: -1803209974
  42.651 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780828) lastTickApplied(22780819) referenceMapTick(22780828) networkTick(1729)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780820) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780820) inputActions((ChangeWalkingState) (CheckCRCHeuristic) ) ) for peer(1)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780821) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780822) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780823) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780824) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780825) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.651 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780826) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  42.652 Info MultiplayerManager.cpp:1861: maptick(22780828) crc after applying all ticks: -874620452
  42.652 Info MultiplayerManager.cpp:996: networkTick(1729) mapTick(22780828) changing state from(InGameAligning) to(InGameAligned)
  42.816 Info MultiplayerManager.cpp:1143: networkTick(1735) mapTick(22780828) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  42.816 Info MultiplayerManager.cpp:1143: networkTick(1735) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedAligning) newState(DesyncedAligned)
  43.007 Info MultiplayerManager.cpp:1419: networkTick(1741) mapTick(22780828) received playerReconnect
  43.007 Info MultiplayerManager.cpp:2236: NetworkTick(1741) MapTick(22780828) disconnecting player(1) from the user.
  43.007 Info NetworkInputHandler.cpp:548: expectedMapTick(22780828) removing peer(1) success(true).
  43.007 Info NetworkInputHandler.cpp:524: expectedMapTick(22780828) adding peer(1).
  43.007 Info MultiplayerManager.cpp:1143: networkTick(1741) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
  44.990 Info MultiplayerManager.cpp:1143: networkTick(1806) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
  44.990 Info MultiplayerManager.cpp:996: networkTick(1806) mapTick(22780828) changing state from(InGameAligned) to(InGameSavingMap)
  44.990 Info MultiplayerManager.cpp:1143: networkTick(1812) mapTick(22780828) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  46.380 Info MultiplayerManager.cpp:996: networkTick(1843) mapTick(22780828) changing state from(InGameSavingMap) to(InGameSendingMap)
  46.433 Info MultiplayerManager.cpp:1260: MapTick(22780828) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16408141) crc(1492379601)
  46.433 Info MultiplayerManager.cpp:1143: networkTick(1849) mapTick(22780828) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  46.552 Info MultiplayerManager.cpp:1143: networkTick(1855) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
  64.824 Info MultiplayerManager.cpp:1143: networkTick(2365) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedDownloadingMap) newState(DesyncedLoadingMap)
  64.825 Canceling serving for peer 1
  64.825 Info MultiplayerManager.cpp:996: networkTick(2365) mapTick(22780828) changing state from(InGameSendingMap) to(InGameWaitingForOthers)
  64.825 Info MultiplayerManager.cpp:1143: networkTick(2371) mapTick(22780828) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
  66.632 Info MultiplayerManager.cpp:1143: networkTick(2441) mapTick(22780828) received stateChanged peerID(1) oldState(DesyncedLoadingMap) newState(InGameWaitingForOthers)
  66.632 Info MultiplayerManager.cpp:1342: networkTick(2441) mapTick(22780828) stopping mapAlign
  66.632 Info MultiplayerManager.cpp:996: networkTick(2441) mapTick(22780828) changing state from(InGameWaitingForOthers) to(InGame)
  66.632 Info MultiplayerManager.cpp:1706: networkTick(2441) mapTick(22780828) peerID(0) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(1) state(InGameWaitingForOthers) mapAlignTick(-1))
)
  66.633 Info MultiplayerManager.cpp:1143: networkTick(2447) mapTick(22780828) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
  66.633 Info MultiplayerManager.cpp:1143: networkTick(2447) mapTick(22780828) received stateChanged peerID(1) oldState(InGameWaitingForOthers) newState(InGame)
  66.730 Info NetworkInputHandler.cpp:608: assigning playerIndex(1) to peer(1)
  66.731 Info GameActionHandler.cpp:2611: MapTick(22780837) processed PlayerJoinGame peerID(1) playerIndex(1) mode(connect)
  67.536 Info MultiplayerManager.cpp:1143: networkTick(2467) mapTick(22780837) received stateChanged peerID(1) oldState(InGame) newState(Desynced)
  67.536 Info MultiplayerManager.cpp:996: networkTick(2467) mapTick(22780837) changing state from(InGame) to(InGameAligning)
  67.536 Info MultiplayerManager.cpp:1818: networkTick(2467) mapTick(22780837) starting mapAlign
  67.536 Info MultiplayerManager.cpp:1143: networkTick(2473) mapTick(22780837) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  67.536 Info MultiplayerManager.cpp:1143: networkTick(2473) mapTick(22780837) received stateChanged peerID(1) oldState(Desynced) newState(DesyncedAligning)
  67.536 Info MultiplayerManager.cpp:1752: networkTick(2473) mapTick(22780837) sending mapAlignAction
  67.619 Info MultiplayerManager.cpp:1390: networkTick(2479) mapTick(22780837) received MapAlignAction from peer(0), mapAlignTick(22780838) appliedTickClosuresCount(0)
  67.619 Info MultiplayerManager.cpp:1390: networkTick(2479) mapTick(22780837) received MapAlignAction from peer(1), mapAlignTick(22780839) appliedTickClosuresCount(16)
  67.619 Info MultiplayerManager.cpp:1834: networkTick(2480) mapTick(22780837) mapAlign finished targetTick(22780839) updating map and running the tasks ...
  67.619 Info MultiplayerManager.cpp:1706: networkTick(2480) mapTick(22780837) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780838))
((peerID(1) state(DesyncedAligning) mapAlignTick(22780839))
)
  67.630 Info MultiplayerManager.cpp:1853: maptick(22780839) crc before applying all ticks: -1395504616
  67.630 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780839) lastTickApplied(22780830) referenceMapTick(22780839) networkTick(2480)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780831) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780831) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780832) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780832) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780833) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780833) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780834) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780834) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780835) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780835) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780836) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780836) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.630 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780837) inputActions((CheckCRCHeuristic) ) ) for peer(1)
  67.631 Info MultiplayerManager.cpp:1861: maptick(22780839) crc after applying all ticks: -1395504616
  67.631 Info MultiplayerManager.cpp:996: networkTick(2480) mapTick(22780839) changing state from(InGameAligning) to(InGameAligned)
  67.732 Info MultiplayerManager.cpp:1143: networkTick(2486) mapTick(22780839) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  67.732 Info MultiplayerManager.cpp:1143: networkTick(2486) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedAligning) newState(DesyncedAligned)
  67.841 Info MultiplayerManager.cpp:1419: networkTick(2492) mapTick(22780839) received playerReconnect
  67.841 Info MultiplayerManager.cpp:2236: NetworkTick(2492) MapTick(22780839) disconnecting player(1) from the user.
  67.841 Info NetworkInputHandler.cpp:548: expectedMapTick(22780839) removing peer(1) success(true).
  67.841 Info NetworkInputHandler.cpp:524: expectedMapTick(22780839) adding peer(1).
  67.841 Info MultiplayerManager.cpp:1143: networkTick(2492) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
  69.874 Info MultiplayerManager.cpp:1143: networkTick(2553) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
  69.874 Info MultiplayerManager.cpp:996: networkTick(2553) mapTick(22780839) changing state from(InGameAligned) to(InGameSavingMap)
  69.874 Info MultiplayerManager.cpp:1143: networkTick(2559) mapTick(22780839) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  71.028 Info MultiplayerManager.cpp:996: networkTick(2575) mapTick(22780839) changing state from(InGameSavingMap) to(InGameSendingMap)
  71.081 Info MultiplayerManager.cpp:1260: MapTick(22780839) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16412317) crc(-1360716145)
  71.081 Info MultiplayerManager.cpp:1143: networkTick(2581) mapTick(22780839) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  71.154 Info MultiplayerManager.cpp:1143: networkTick(2587) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
  87.426 Info MultiplayerManager.cpp:1143: networkTick(3109) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedDownloadingMap) newState(DesyncedLoadingMap)
  87.426 Canceling serving for peer 1
  87.426 Info MultiplayerManager.cpp:996: networkTick(3109) mapTick(22780839) changing state from(InGameSendingMap) to(InGameWaitingForOthers)
  87.777 Info MultiplayerManager.cpp:1143: networkTick(3115) mapTick(22780839) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
  89.003 Info MultiplayerManager.cpp:1143: networkTick(3161) mapTick(22780839) received stateChanged peerID(1) oldState(DesyncedLoadingMap) newState(InGameWaitingForOthers)
  89.003 Info MultiplayerManager.cpp:1342: networkTick(3161) mapTick(22780839) stopping mapAlign
  89.003 Info MultiplayerManager.cpp:996: networkTick(3161) mapTick(22780839) changing state from(InGameWaitingForOthers) to(InGame)
  89.003 Info MultiplayerManager.cpp:1706: networkTick(3161) mapTick(22780839) peerID(0) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(1) state(InGameWaitingForOthers) mapAlignTick(-1))
)
  89.080 Info MultiplayerManager.cpp:1143: networkTick(3167) mapTick(22780845) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
  89.080 Info MultiplayerManager.cpp:1143: networkTick(3167) mapTick(22780845) received stateChanged peerID(1) oldState(InGameWaitingForOthers) newState(InGame)
  89.098 Info NetworkInputHandler.cpp:608: assigning playerIndex(1) to peer(1)
  89.098 Info GameActionHandler.cpp:2611: MapTick(22780848) processed PlayerJoinGame peerID(1) playerIndex(1) mode(connect)
  89.159 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780840) peer(1) testCrc(791511928) testCrcPeerID(0) currentCrc(-101373354)
  89.159 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 791511928, reference peers = {0}, desynced group = {CRC = 4193593942, peers = {1 (IsoSchiz)}}
  89.165 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780841) peer(1) testCrc(2132551117) testCrcPeerID(0) currentCrc(-959644365)
  89.165 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2132551117, reference peers = {0}, desynced group = {CRC = 3335322931, peers = {1 (IsoSchiz)}}
  89.171 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780842) peer(1) testCrc(-1844153999) testCrcPeerID(0) currentCrc(-968621643)
  89.171 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2450813297, reference peers = {0}, desynced group = {CRC = 3326345653, peers = {1 (IsoSchiz)}}
  89.177 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780843) peer(1) testCrc(-1633739511) testCrcPeerID(0) currentCrc(-892375603)
  89.177 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2661227785, reference peers = {0}, desynced group = {CRC = 3402591693, peers = {1 (IsoSchiz)}}
  89.183 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780844) peer(1) testCrc(1633557039) testCrcPeerID(0) currentCrc(-1649505437)
  89.183 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 1633557039, reference peers = {0}, desynced group = {CRC = 2645461859, peers = {1 (IsoSchiz)}}
  89.214 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780845) peer(1) testCrc(-266204775) testCrcPeerID(0) currentCrc(-1536001699)
  89.214 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 4028762521, reference peers = {0}, desynced group = {CRC = 2758965597, peers = {1 (IsoSchiz)}}
  89.220 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780846) peer(1) testCrc(-2018427963) testCrcPeerID(0) currentCrc(-740209919)
  89.220 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2276539333, reference peers = {0}, desynced group = {CRC = 3554757377, peers = {1 (IsoSchiz)}}
  89.226 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780847) peer(1) testCrc(-1302330079) testCrcPeerID(0) currentCrc(-1002373802)
  89.226 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2992637217, reference peers = {0}, desynced group = {CRC = 3292593494, peers = {1 (IsoSchiz)}}
  89.384 Info MultiplayerManager.cpp:1143: networkTick(3179) mapTick(22780856) received stateChanged peerID(1) oldState(InGame) newState(Desynced)
  89.384 Info MultiplayerManager.cpp:996: networkTick(3179) mapTick(22780856) changing state from(InGame) to(InGameAligning)
  89.384 Info MultiplayerManager.cpp:1818: networkTick(3179) mapTick(22780856) starting mapAlign
  89.384 Info MultiplayerManager.cpp:1143: networkTick(3185) mapTick(22780856) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
  89.384 Info MultiplayerManager.cpp:1143: networkTick(3185) mapTick(22780856) received stateChanged peerID(1) oldState(Desynced) newState(DesyncedAligning)
  89.384 Info MultiplayerManager.cpp:1752: networkTick(3185) mapTick(22780856) sending mapAlignAction
  89.476 Info MultiplayerManager.cpp:1390: networkTick(3191) mapTick(22780856) received MapAlignAction from peer(0), mapAlignTick(22780857) appliedTickClosuresCount(0)
  89.476 Info MultiplayerManager.cpp:1390: networkTick(3191) mapTick(22780856) received MapAlignAction from peer(1), mapAlignTick(22780850) appliedTickClosuresCount(24)
  89.476 Info MultiplayerManager.cpp:1834: networkTick(3192) mapTick(22780856) mapAlign finished targetTick(22780857) updating map and running the tasks ...
  89.476 Info MultiplayerManager.cpp:1706: networkTick(3192) mapTick(22780856) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780857))
((peerID(1) state(DesyncedAligning) mapAlignTick(22780850))
)
  89.483 Info MultiplayerManager.cpp:1853: maptick(22780857) crc before applying all ticks: -483089958
  89.483 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780857) lastTickApplied(22780848) referenceMapTick(22780857) networkTick(3192)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780849) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780850) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780851) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780852) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780853) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780854) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.483 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780855) inputActions((CheckCRCHeuristic) ) ) for peer(0)
  89.484 Info MultiplayerManager.cpp:1861: maptick(22780857) crc after applying all ticks: -483089958
  89.484 Info MultiplayerManager.cpp:996: networkTick(3192) mapTick(22780857) changing state from(InGameAligning) to(InGameAligned)
  89.859 Info MultiplayerManager.cpp:1143: networkTick(3198) mapTick(22780857) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
  89.859 Info MultiplayerManager.cpp:1143: networkTick(3198) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedAligning) newState(DesyncedAligned)
  90.640 Info MultiplayerManager.cpp:1419: networkTick(3204) mapTick(22780857) received playerReconnect
  90.640 Info MultiplayerManager.cpp:2236: NetworkTick(3204) MapTick(22780857) disconnecting player(1) from the user.
  90.640 Info NetworkInputHandler.cpp:548: expectedMapTick(22780857) removing peer(1) success(true).
  90.640 Info NetworkInputHandler.cpp:524: expectedMapTick(22780857) adding peer(1).
  90.640 Info MultiplayerManager.cpp:1143: networkTick(3204) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
  91.944 Info MultiplayerManager.cpp:1143: networkTick(3238) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
  91.944 Info MultiplayerManager.cpp:996: networkTick(3238) mapTick(22780857) changing state from(InGameAligned) to(InGameSavingMap)
  91.944 Info MultiplayerManager.cpp:1143: networkTick(3244) mapTick(22780857) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
  93.154 Info MultiplayerManager.cpp:996: networkTick(3290) mapTick(22780857) changing state from(InGameSavingMap) to(InGameSendingMap)
  93.206 Info MultiplayerManager.cpp:1260: MapTick(22780857) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16411318) crc(1243484598)
  93.428 Info MultiplayerManager.cpp:1143: networkTick(3296) mapTick(22780857) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
  93.428 Info MultiplayerManager.cpp:1143: networkTick(3302) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
 104.193 Info Synchronizer.cpp:465: NetworkTick(3568) peer(1) drop detection state(100/900).
 107.613 Info MultiplayerManager.cpp:1143: networkTick(3642) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedDownloadingMap) newState(DesyncedLoadingMap)
 107.613 Canceling serving for peer 1
 107.613 Info MultiplayerManager.cpp:996: networkTick(3642) mapTick(22780857) changing state from(InGameSendingMap) to(InGameWaitingForOthers)
 107.822 Info MultiplayerManager.cpp:1143: networkTick(3648) mapTick(22780857) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
 110.361 Info MultiplayerManager.cpp:1143: networkTick(3693) mapTick(22780857) received stateChanged peerID(1) oldState(DesyncedLoadingMap) newState(InGameWaitingForOthers)
 110.361 Info MultiplayerManager.cpp:1342: networkTick(3693) mapTick(22780857) stopping mapAlign
 110.361 Info MultiplayerManager.cpp:996: networkTick(3693) mapTick(22780857) changing state from(InGameWaitingForOthers) to(InGame)
 110.361 Info MultiplayerManager.cpp:1706: networkTick(3693) mapTick(22780857) peerID(0) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(1) state(InGameWaitingForOthers) mapAlignTick(-1))
)
 110.362 Info MultiplayerManager.cpp:1143: networkTick(3699) mapTick(22780857) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
 110.362 Info MultiplayerManager.cpp:1143: networkTick(3699) mapTick(22780857) received stateChanged peerID(1) oldState(InGameWaitingForOthers) newState(InGame)
 110.807 Info NetworkInputHandler.cpp:608: assigning playerIndex(1) to peer(1)
 110.807 Info GameActionHandler.cpp:2611: MapTick(22780866) processed PlayerJoinGame peerID(1) playerIndex(1) mode(connect)
 110.813 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780858) peer(1) testCrc(2110370111) testCrcPeerID(0) currentCrc(-1424943087)
 110.813 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2110370111, reference peers = {0}, desynced group = {CRC = 2870024209, peers = {1 (IsoSchiz)}}
 110.819 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780859) peer(1) testCrc(-1585081689) testCrcPeerID(0) currentCrc(-1951552827)
 110.819 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2709885607, reference peers = {0}, desynced group = {CRC = 2343414469, peers = {1 (IsoSchiz)}}
 110.825 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780860) peer(1) testCrc(-1347615239) testCrcPeerID(0) currentCrc(-2054865509)
 110.825 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 2947352057, reference peers = {0}, desynced group = {CRC = 2240101787, peers = {1 (IsoSchiz)}}
 110.831 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780861) peer(1) testCrc(1051337589) testCrcPeerID(0) currentCrc(-1034243527)
 110.831 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 1051337589, reference peers = {0}, desynced group = {CRC = 3260723769, peers = {1 (IsoSchiz)}}
 110.838 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780862) peer(1) testCrc(1936939065) testCrcPeerID(0) currentCrc(1499160667)
 110.841 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 1936939065, reference peers = {0}, desynced group = {CRC = 1499160667, peers = {1 (IsoSchiz)}}
 110.874 Error NetworkInputHandler.cpp:375: Multiplayer desynchronisation: crc test(CheckCRCHeuristic) failed for mapTick(22780864) peer(1) testCrc(-145128271) testCrcPeerID(0) currentCrc(-1994273769)
 110.874 Info NetworkInputHandler.cpp:442: Desync specification: Reference CRC = 4149839025, reference peers = {0}, desynced group = {CRC = 2300693527, peers = {1 (IsoSchiz)}}
 111.373 Info MultiplayerManager.cpp:1143: networkTick(3731) mapTick(22780874) received stateChanged peerID(1) oldState(InGame) newState(Desynced)
 111.373 Info MultiplayerManager.cpp:996: networkTick(3731) mapTick(22780874) changing state from(InGame) to(InGameAligning)
 111.373 Info MultiplayerManager.cpp:1818: networkTick(3731) mapTick(22780874) starting mapAlign
 111.373 Info MultiplayerManager.cpp:1143: networkTick(3737) mapTick(22780874) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
 111.373 Info MultiplayerManager.cpp:1143: networkTick(3737) mapTick(22780874) received stateChanged peerID(1) oldState(Desynced) newState(DesyncedAligning)
 111.373 Info MultiplayerManager.cpp:1752: networkTick(3737) mapTick(22780874) sending mapAlignAction
 111.708 Info MultiplayerManager.cpp:1390: networkTick(3743) mapTick(22780874) received MapAlignAction from peer(0), mapAlignTick(22780875) appliedTickClosuresCount(0)
 111.708 Info MultiplayerManager.cpp:1390: networkTick(3743) mapTick(22780874) received MapAlignAction from peer(1), mapAlignTick(22780868) appliedTickClosuresCount(24)
 111.708 Info MultiplayerManager.cpp:1834: networkTick(3744) mapTick(22780874) mapAlign finished targetTick(22780875) updating map and running the tasks ...
 111.708 Info MultiplayerManager.cpp:1706: networkTick(3744) mapTick(22780874) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780875))
((peerID(1) state(DesyncedAligning) mapAlignTick(22780868))
)
 111.716 Info MultiplayerManager.cpp:1853: maptick(22780875) crc before applying all ticks: -354486164
 111.716 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780875) lastTickApplied(22780866) referenceMapTick(22780875) networkTick(3744)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780867) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780868) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780869) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780870) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780871) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780872) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780873) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 111.716 Info MultiplayerManager.cpp:1861: maptick(22780875) crc after applying all ticks: -354486164
 111.716 Info MultiplayerManager.cpp:996: networkTick(3744) mapTick(22780875) changing state from(InGameAligning) to(InGameAligned)
 111.717 Info MultiplayerManager.cpp:1143: networkTick(3750) mapTick(22780875) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
 111.717 Info MultiplayerManager.cpp:1143: networkTick(3750) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedAligning) newState(DesyncedAligned)
 111.996 Info MultiplayerManager.cpp:1419: networkTick(3756) mapTick(22780875) received playerReconnect
 111.996 Info MultiplayerManager.cpp:2236: NetworkTick(3756) MapTick(22780875) disconnecting player(1) from the user.
 111.996 Info NetworkInputHandler.cpp:548: expectedMapTick(22780875) removing peer(1) success(true).
 111.996 Info NetworkInputHandler.cpp:524: expectedMapTick(22780875) adding peer(1).
 111.996 Info MultiplayerManager.cpp:1143: networkTick(3756) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
 114.613 Info MultiplayerManager.cpp:1143: networkTick(3808) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
 114.613 Info MultiplayerManager.cpp:996: networkTick(3808) mapTick(22780875) changing state from(InGameAligned) to(InGameSavingMap)
 114.613 Info MultiplayerManager.cpp:1143: networkTick(3814) mapTick(22780875) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
 115.769 Info MultiplayerManager.cpp:996: networkTick(3833) mapTick(22780875) changing state from(InGameSavingMap) to(InGameSendingMap)
 115.821 Info MultiplayerManager.cpp:1260: MapTick(22780875) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16413382) crc(-143518240)
 116.239 Info MultiplayerManager.cpp:1143: networkTick(3839) mapTick(22780875) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
 116.240 Info MultiplayerManager.cpp:1143: networkTick(3845) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
 130.841 Info MultiplayerManager.cpp:1143: networkTick(4347) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedDownloadingMap) newState(DesyncedLoadingMap)
 130.841 Canceling serving for peer 1
 130.842 Info MultiplayerManager.cpp:996: networkTick(4347) mapTick(22780875) changing state from(InGameSendingMap) to(InGameWaitingForOthers)
 131.348 Info MultiplayerManager.cpp:1143: networkTick(4353) mapTick(22780875) received stateChanged peerID(0) oldState(InGameSendingMap) newState(InGameWaitingForOthers)
 133.428 Info MultiplayerManager.cpp:1143: networkTick(4382) mapTick(22780875) received stateChanged peerID(1) oldState(DesyncedLoadingMap) newState(InGameWaitingForOthers)
 133.428 Info MultiplayerManager.cpp:1342: networkTick(4382) mapTick(22780875) stopping mapAlign
 133.428 Info MultiplayerManager.cpp:996: networkTick(4382) mapTick(22780875) changing state from(InGameWaitingForOthers) to(InGame)
 133.428 Info MultiplayerManager.cpp:1706: networkTick(4382) mapTick(22780875) peerID(0) fullStateLog: local state(InGame) local peers(((peerID(0) state(InGameWaitingForOthers) mapAlignTick(-1))
((peerID(1) state(InGameWaitingForOthers) mapAlignTick(-1))
)
 133.428 Info MultiplayerManager.cpp:1143: networkTick(4388) mapTick(22780875) received stateChanged peerID(0) oldState(InGameWaitingForOthers) newState(InGame)
 133.428 Info MultiplayerManager.cpp:1143: networkTick(4388) mapTick(22780875) received stateChanged peerID(1) oldState(InGameWaitingForOthers) newState(InGame)
 136.500 Info MultiplayerManager.cpp:1143: networkTick(4445) mapTick(22780882) received stateChanged peerID(1) oldState(InGame) newState(Desynced)
 136.500 Info MultiplayerManager.cpp:996: networkTick(4445) mapTick(22780882) changing state from(InGame) to(InGameAligning)
 136.500 Info MultiplayerManager.cpp:1818: networkTick(4445) mapTick(22780882) starting mapAlign
 136.500 Info MultiplayerManager.cpp:1143: networkTick(4451) mapTick(22780882) received stateChanged peerID(0) oldState(InGame) newState(InGameAligning)
 136.500 Info MultiplayerManager.cpp:1143: networkTick(4451) mapTick(22780882) received stateChanged peerID(1) oldState(Desynced) newState(DesyncedAligning)
 136.500 Info MultiplayerManager.cpp:1752: networkTick(4451) mapTick(22780882) sending mapAlignAction
 136.834 Info MultiplayerManager.cpp:1390: networkTick(4457) mapTick(22780882) received MapAlignAction from peer(0), mapAlignTick(22780883) appliedTickClosuresCount(0)
 136.841 Info MultiplayerManager.cpp:1390: networkTick(4457) mapTick(22780882) received MapAlignAction from peer(1), mapAlignTick(22780886) appliedTickClosuresCount(14)
 136.841 Info MultiplayerManager.cpp:1834: networkTick(4458) mapTick(22780882) mapAlign finished targetTick(22780886) updating map and running the tasks ...
 136.841 Info MultiplayerManager.cpp:1706: networkTick(4458) mapTick(22780882) peerID(0) fullStateLog: local state(InGameAligning) local peers(((peerID(0) state(InGameAligning) mapAlignTick(22780883))
((peerID(1) state(DesyncedAligning) mapAlignTick(22780886))
)
 136.851 Info NetworkInputHandler.cpp:608: assigning playerIndex(1) to peer(1)
 136.851 Info GameActionHandler.cpp:2611: MapTick(22780884) processed PlayerJoinGame peerID(1) playerIndex(1) mode(connect)
 136.861 Info MultiplayerManager.cpp:1853: maptick(22780886) crc before applying all ticks: 1478281635
 136.861 Info NetworkInputHandler.cpp:670: applyAllTickClosures: expectedMapTick(22780886) lastTickApplied(22780877) referenceMapTick(22780886) networkTick(4458)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780878) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780878) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780879) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780879) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780880) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780880) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780881) inputActions((CheckCRCHeuristic) ) ) for peer(0)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780881) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780882) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780883) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info NetworkInputHandler.cpp:694: applyAllTickClosures: applying tickClosure(tick(22780884) inputActions((CheckCRCHeuristic) ) ) for peer(1)
 136.861 Info MultiplayerManager.cpp:1861: maptick(22780886) crc after applying all ticks: 1478281635
 136.861 Info MultiplayerManager.cpp:996: networkTick(4458) mapTick(22780886) changing state from(InGameAligning) to(InGameAligned)
 136.862 Info MultiplayerManager.cpp:1143: networkTick(4464) mapTick(22780886) received stateChanged peerID(0) oldState(InGameAligning) newState(InGameAligned)
 136.862 Info MultiplayerManager.cpp:1143: networkTick(4464) mapTick(22780886) received stateChanged peerID(1) oldState(DesyncedAligning) newState(DesyncedAligned)
 137.285 Info MultiplayerManager.cpp:1419: networkTick(4470) mapTick(22780886) received playerReconnect
 137.285 Info MultiplayerManager.cpp:2236: NetworkTick(4470) MapTick(22780886) disconnecting player(1) from the user.
 137.285 Info NetworkInputHandler.cpp:548: expectedMapTick(22780886) removing peer(1) success(true).
 137.285 Info NetworkInputHandler.cpp:524: expectedMapTick(22780886) adding peer(1).
 137.285 Info MultiplayerManager.cpp:1143: networkTick(4470) mapTick(22780886) received stateChanged peerID(1) oldState(DesyncedAligned) newState(DesyncedCreatingReport)
 140.402 Info MultiplayerManager.cpp:1143: networkTick(4509) mapTick(22780886) received stateChanged peerID(1) oldState(DesyncedCreatingReport) newState(DesyncedWaitingForMap)
 140.402 Info MultiplayerManager.cpp:996: networkTick(4509) mapTick(22780886) changing state from(InGameAligned) to(InGameSavingMap)
 140.402 Info MultiplayerManager.cpp:1143: networkTick(4515) mapTick(22780886) received stateChanged peerID(0) oldState(InGameAligned) newState(InGameSavingMap)
 140.403 Info Synchronizer.cpp:465: NetworkTick(4521) peer(1) drop detection state(100/900).
 141.973 Info MultiplayerManager.cpp:996: networkTick(4522) mapTick(22780886) changing state from(InGameSavingMap) to(InGameSendingMap)
 142.024 Info MultiplayerManager.cpp:1260: MapTick(22780886) Serving map(/opt/factorio/temp/mp-download.zip) for peer(1) size(16411083) crc(770936178)
 142.024 Info MultiplayerManager.cpp:1143: networkTick(4528) mapTick(22780886) received stateChanged peerID(0) oldState(InGameSavingMap) newState(InGameSendingMap)
 142.146 Info MultiplayerManager.cpp:1143: networkTick(4534) mapTick(22780886) received stateChanged peerID(1) oldState(DesyncedWaitingForMap) newState(DesyncedDownloadingMap)
 145.089 Info Synchronizer.cpp:465: NetworkTick(4587) peer(1) drop detection state(100/900).
Jerub
Burner Inserter
Burner Inserter
Posts: 7
Joined: Mon Jun 27, 2016 8:19 pm
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Jerub »

This bug is related to the same situation: viewtopic.php?f=7&t=27677
Rseding91
Factorio Staff
Factorio Staff
Posts: 14766
Joined: Wed Jun 11, 2014 5:23 am
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Rseding91 »

Can you reproduce the desync when loading the 0.12 save in 0.13.1?
If you want to get ahold of me I'm almost always on Discord.
Jerub
Burner Inserter
Burner Inserter
Posts: 7
Joined: Mon Jun 27, 2016 8:19 pm
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Jerub »

Attached a save file that's a 0.12.35 game that we took straight to 0.13.1
Attachments
0.12.35-save.zip
Save from 0.12.35 that we upgraded to 0.13.1 skipping 0.13.0
(28.32 MiB) Downloaded 76 times
Jerub
Burner Inserter
Burner Inserter
Posts: 7
Joined: Mon Jun 27, 2016 8:19 pm
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Jerub »

To be clear: yes, we can replicate the problem with a save that wasn't run with 0.13.0
Jerub
Burner Inserter
Burner Inserter
Posts: 7
Joined: Mon Jun 27, 2016 8:19 pm
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Jerub »

Aaaaand now I realise I had the wrong save in that test. Yes: loading a 0.12.35 save from before we played on 0.13.0 always works.

Sorry about the noise.
Rseding91
Factorio Staff
Factorio Staff
Posts: 14766
Joined: Wed Jun 11, 2014 5:23 am
Contact:

Re: [0.13.1] Reliable desync on server join

Post by Rseding91 »

Jerub wrote:Aaaaand now I realise I had the wrong save in that test. Yes: loading a 0.12.35 save from before we played on 0.13.0 always works.

Sorry about the noise.
So you're saying no desync when 0.12 -> 0.13.1?
If you want to get ahold of me I'm almost always on Discord.
Post Reply

Return to “Pending”