[Oxyd] [0.18.28] Stuck on waiting to save map
Posted: Fri May 29, 2020 7:35 pm
by Cooldude2606
When trying to connect to some multiplayer games it will get stuck on the waiting for server to save map screen. This happans on multiple servers and is more frequent on servers with small maps. I also know, through hosting the deadicated server, that multiple people will experience this while connecting to our server. Our server has non blocking saving enabled if this has any effect. Below are the server logs and client logs when I have the issue. The logs include me pressing esc to cancel the connection as it will just hang with no further log activity. From what I can make of the logs the client never receives mapReadyForDownload and then everything just hangs. The invalid packet states are common to both successful joins and failed joins, and downloading the map never has any issues once it starts.
Server Logs Fail
Code: Select all
84798.783 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(IP ADDR:({CLIENT_ADDR:57423}))
84798.783 Info ServerRouter.cpp:425: Replying to connectionRequest for address(IP ADDR:({CLIENT_ADDR:57423})).
84798.783 Info ServerSynchronizer.cpp:599: nextHeartbeatSequenceNumber(2526614) adding peer(62)
84798.801 Info ServerMultiplayerManager.cpp:771: updateTick(128393) changing state from(InGame) to(InGameSavingMap)
84798.972 Info ServerMultiplayerManager.cpp:986: UpdateTick(128393) Serving map(/opt/factorio-servers/factorio-eu-08/temp/mp-save-61.zip) for peer(62) size(2593231) crc(1143283117)
84798.972 Info ServerMultiplayerManager.cpp:771: updateTick(128393) changing state from(InGameSavingMap) to(InGame)
84799.278 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(IP ADDR:({CLIENT_ADDR:57423}))
84799.278 Info ServerRouter.cpp:425: Replying to connectionRequest for address(IP ADDR:({CLIENT_ADDR:57423})).
84799.653 Info ServerMultiplayerManager.cpp:919: updateTick(128433) received stateChanged peerID(62) oldState(Ready) newState(ConnectedWaitingForMap)
84823.211 Info RemoteCommandProcessor.cpp:238: New RCON connection from IP ADDR:({216.245.221.88:37752})
84872.297 Info ServerMultiplayerManager.cpp:1037: Disconnect notification for peer (62)
84872.297 Info ServerMultiplayerManager.cpp:919: updateTick(128579) received stateChanged peerID(62) oldState(ConnectedWaitingForMap) newState(DisconnectScheduled)
84872.314 Info ServerSynchronizer.cpp:618: nextHeartbeatSequenceNumber(2528803) removing peer(62).
Client Logs Fail
Code: Select all
647.474 Joining game IP ADDR:({5.196.93.138:34204})
647.474 Info UDPSocket.cpp:33: Opening socket
647.475 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Ready) to(Connecting)
647.884 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.884 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.884 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.884 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.884 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.902 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.902 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.902 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.902 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.918 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.951 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
647.983 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
648.018 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
648.050 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
648.385 Info ClientSynchronizer.cpp:35: Initialized Synchronizer local peer(1) latency(32).
648.385 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Connecting) to(ConnectedWaitingForMap)
648.386 Info ClientRouter.cpp:221: ConnectionAccepted
648.386 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
648.951 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
649.417 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
721.019 Info ClientMultiplayerManager.cpp:144: Disconnecting multiplayer connection. Reason: Quit.
721.019 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(ConnectedWaitingForMap) to(DisconnectScheduled)
721.035 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(DisconnectScheduled) to(WaitingForDisconnectConfirmation)
721.135 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(WaitingForDisconnectConfirmation) to(Disconnected)
721.135 Info ClientMultiplayerManager.cpp:891: Disconnect notification for peer (62)
721.138 Info UDPSocket.cpp:218: Closing socket
721.138 Info UDPSocket.cpp:248: Socket closed
Server Logs Success
Code: Select all
86232.215 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(IP ADDR:({CLIENT_ADDR:62845}))
86232.215 Info ServerRouter.cpp:425: Replying to connectionRequest for address(IP ADDR:({CLIENT_ADDR:62845})).
86232.215 Info ServerSynchronizer.cpp:599: nextHeartbeatSequenceNumber(2569307) adding peer(84)
86232.234 Info ServerMultiplayerManager.cpp:771: updateTick(130884) changing state from(InGame) to(InGameSavingMap)
86232.405 Info ServerMultiplayerManager.cpp:986: UpdateTick(130884) Serving map(/opt/factorio-servers/factorio-eu-08/temp/mp-save-83.zip) for peer(84) size(2593302) crc(3960836900)
86232.405 Info ServerMultiplayerManager.cpp:771: updateTick(130884) changing state from(InGameSavingMap) to(InGame)
86232.744 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(IP ADDR:({CLIENT_ADDR:62845}))
86232.744 Info ServerRouter.cpp:425: Replying to connectionRequest for address(IP ADDR:({CLIENT_ADDR:62845})).
86232.780 Info ServerMultiplayerManager.cpp:919: updateTick(130906) received stateChanged peerID(84) oldState(Ready) newState(ConnectedWaitingForMap)
86233.790 Info ServerMultiplayerManager.cpp:919: updateTick(130908) received stateChanged peerID(84) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
86235.084 Info ServerMultiplayerManager.cpp:919: updateTick(130910) received stateChanged peerID(84) oldState(ConnectedDownloadingMap) newState(ConnectedLoadingMap)
86236.255 Info ServerMultiplayerManager.cpp:919: updateTick(130979) received stateChanged peerID(84) oldState(ConnectedLoadingMap) newState(TryingToCatchUp)
86236.391 Info ServerMultiplayerManager.cpp:919: updateTick(130987) received stateChanged peerID(84) oldState(TryingToCatchUp) newState(WaitingForCommandToStartSendingTickClosures)
86236.391 Info GameActionHandler.cpp:4308: UpdateTick (130987) processed PlayerJoinGame peerID(84) playerIndex(0) mode(connect)
Client Logs Success
Code: Select all
2080.901 Joining game IP ADDR:({5.196.93.138:34204})
2080.901 Info UDPSocket.cpp:33: Opening socket
2080.902 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Ready) to(Connecting)
2081.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.301 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.301 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.301 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.301 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.316 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.351 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.385 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.418 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.450 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.485 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({5.196.93.138:34204}): invalid state (WaitingForAccept) for packet type
2081.502 Info ClientSynchronizer.cpp:35: Initialized Synchronizer local peer(1) latency(32).
2081.502 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Connecting) to(ConnectedWaitingForMap)
2081.502 Info ClientRouter.cpp:221: ConnectionAccepted
2082.068 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
2082.468 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
2082.485 Info ClientMultiplayerManager.cpp:750: Received mapReadyForDownload
2082.485 Downloading file C:\Users\User\AppData\Roaming\Factorio\temp\mp-download.zip (2593302 B, 5156 blocks)
2082.487 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(ConnectedWaitingForMap) to(ConnectedDownloadingMap)
2082.833 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ConnectionAcceptOrDeny) received from IP ADDR:({5.196.93.138:34204}): invalid state (Connected) for packet type
2083.752 Finished download (1 s, 2.5 MB, 2.0 MB/s)
2083.778 Info ClientMultiplayerManager.cpp:730: updateTick(4294967295) map download finished creating scenario
2083.778 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(ConnectedDownloadingMap) to(ConnectedLoadingMap)