[14.8] [Cube] Crash in MP after: "connection has been broken due to keep-alive activity"

[Rhamphoryncus]

Playing vanilla MP 0.14.8. Only one other player, the host. Second time this happened in a few minutes, both right after a biter attack while I was rebuilding mines, ammo, and more turrets. Very early game. Dialog popped up said "The connection has been broken due to keep-alive activity detecting a failure while the operation was in progress." The game was slowly timing me out from the server while the dialog was up. After closing the dialog the game crashed.

Autosave is pretty far from the crash, unfortunately. Logs from both crashes included.

[bor]

hello,
I have a headless server, and we just got server not responding in the middle of the game.
when I checked the server the error in the attached image showed up.
and after clicking on ok the server crashed. log is attached.

[Xelephant]

There seems to be a problem with handling a Networkpacket maybe? My Server crashed three time up to now with this error. I'm using the Base Game only no mods; Running the headless server on windows 64bit.

Code: Select all

11933.603 Info ServerSynchronizer.cpp:524: nextHeartbeatSequenceNumber(346615) adding peer(71)
11933.618 Info ServerMultiplayerManager.cpp:636: mapTick(9676809) changing state from(InGame) to(InGameSavingMap)
11933.686 Info ServerMultiplayerManager.cpp:720: mapTick(9676809) received stateChanged peerID(71) oldState(Ready) newState(ConnectedWaitingForMap)
11938.267 Info ServerMultiplayerManager.cpp:756: MapTick(9676809) Serving map(C) for peer(71) size(29639822) crc(3286467084)
11938.268 Info ServerMultiplayerManager.cpp:636: mapTick(9676809) changing state from(InGameSavingMap) to(InGame)
11938.392 Info ServerMultiplayerManager.cpp:720: mapTick(9676820) received stateChanged peerID(71) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
11941.698 Error Util.cpp:57: Unhandled exception: Recvfrom failed: Die Verbindung wurde aufgrund von Keepalive-Aktivit嵥n abgebrochen, da bei dem Vorgang ein Fehler festgestellt wurde.

11959.581 Error RouterBase.cpp:64: Unhandled exception: Recvfrom failed: Die Verbindung wurde aufgrund von Keepalive-Aktivit嵥n abgebrochen, da bei dem Vorgang ein Fehler festgestellt wurde.

Factorio crashed. Generating symbolized stacktrace, please wait ...
c:\cygwin64\tmp\factorio-rzrhjm\libraries\stackwalker\stackwalker.cpp (906): StackWalker::ShowCallstack
11960.586 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (71)
11960.588 Info ServerSynchronizer.cpp:539: nextHeartbeatSequenceNumber(347462) removing peer(71).
c:\cygwin64\tmp\factorio-rzrhjm\src\util\logger.cpp (332): Logger::writeStacktrace
c:\cygwin64\tmp\factorio-rzrhjm\src\util\logger.cpp (386): Logger::logStacktrace
c:\cygwin64\tmp\factorio-rzrhjm\src\util\crashhandler.cpp (105): CrashHandler::writeStackTrace
c:\cygwin64\tmp\factorio-rzrhjm\src\util\crashhandler.cpp (233): CrashHandler::SignalHandler
d:\th\minkernel\crts\ucrt\src\appcrt\misc\signal.cpp (516): raise
d:\th\minkernel\crts\ucrt\src\appcrt\startup\abort.cpp (71): abort
c:\cygwin64\tmp\factorio-rzrhjm\src\util\exceptions.cpp (36): unhandledException
c:\cygwin64\tmp\factorio-rzrhjm\src\net\routerbase.cpp (64): `RouterBase::readPacketsLoop'::`1'::catch$1
f:\dd\vctools\crt\vcruntime\src\eh\amd64\handlers.asm (50): _CallSettingFrame
f:\dd\vctools\crt\vcruntime\src\eh\frame.cpp (1316): __CxxCallCatchBlock
ERROR: SymGetLineFromAddr64, GetLastError: 487 (Address: 00007FF896CD2A63)
00007FF896CD2A63 (ntdll): (filename not available): RtlCaptureContext
c:\cygwin64\tmp\factorio-rzrhjm\src\net\routerbase.cpp (38): RouterBase::readPacketsLoop
c:\program files (x86)\microsoft visual studio 14.0\vc\include\thr\xthread (247): std::_LaunchPad<std::unique_ptr<std::tuple<void (__cdecl RouterBase::*)(void) __ptr64,ServerRouter * __ptr64>,std::default_delete<std::tuple<void (__cdecl RouterBase::*)(void) __ptr64,ServerRouter * __ptr64> > > >::_Run
c:\program files (x86)\microsoft visual studio 14.0\vc\include\thr\xthread (210): std::_Pad::_Call_func
d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp (115): thread_start<unsigned int (__cdecl*)(void * __ptr64)>
ERROR: SymGetLineFromAddr64, GetLastError: 487 (Address: 00007FF895D913D2)
00007FF895D913D2 (KERNEL32): (filename not available): BaseThreadInitThunk
ERROR: SymGetLineFromAddr64, GetLastError: 487 (Address: 00007FF896C554E4)
00007FF896C554E4 (ntdll): (filename not available): RtlUserThreadStart
11960.625 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (62)
11960.626 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (68)
11960.630 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (70)
11960.632 Info ServerSynchronizer.cpp:539: nextHeartbeatSequenceNumber(347463) removing peer(62).
11960.634 Info ServerSynchronizer.cpp:539: nextHeartbeatSequenceNumber(347463) removing peer(68).
11960.823 Info ServerSynchronizer.cpp:539: nextHeartbeatSequenceNumber(347463) removing peer(70).
11960.937 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (59)
11960.938 Info ServerMultiplayerManager.cpp:798: Disconnect notification for peer (65)
11960.949 Info ServerSynchronizer.cpp:539: nextHeartbeatSequenceNumber(347464) removing peer(59).
11961.269 Error CrashHandler.cpp:106: Map tick at moment of crash: 9678140
11961.270 Error Util.cpp:77: Unexpected error occurred. If you're running the latest version of the game you can help us solve the problem by posting the contents of the log file on the Factorio forums.
Please also include the save file(s), any mods you may be using, and any steps you know of to reproduce the crash.

[Loewchen]

There seems to be a problem with handling a Networkpacket maybe? My Server crashed three time up to now with this error. I'm using the Base Game only no mods; Running the headless server on windows 64bit.

I am reasonably sure that I found another report with that issue. Please provide the initialisation part of the server log as well, it might help narrowing it down.

[Xelephant]

Here is the beginning of the log.

Code: Select all

 0.007 2016-09-24 21:12:24; Factorio 0.14.9 (build 24809, win64, alpha)
   0.015 Operating system: Windows 8.1 
   0.016 Program arguments: "Factorio.exe" "--start-server-load-latest" "--autosave-interval" "20" "--autosave-slots" "3" "--port" "27016" "--allow-commands" "false" "--server-setting" "C:\Users\Administrator\Desktop\factorioMods2\data\server.json" "--rcon-port" "XXXX" "--rcon-password" "YYYYYY" 
   0.016 Read data path: C:/Users/Administrator/Desktop/FactorioMods2/data
   0.017 Write data path: C:/Users/Administrator/Desktop/FactorioMods2
   0.017 Binaries path: C:/Users/Administrator/Desktop/FactorioMods2/bin
   0.039 System info: [CPU: Intel(R) Xeon(R) CPU E5-2630 v3 @ 2.40GHz, 4 cores, RAM: 16383MB]
   0.040 Running in headless mode
   0.044 Loading mod core 0.0.0 (data.lua)
   0.051 Loading mod base 0.14.9 (data.lua)
   0.217 Checksum for core: 1620335853
   0.218 Checksum for mod base: 1378211439
   0.741 Info PlayerData.cpp:45: Local player-data.json available, timestamp 1474651115
   0.742 Info PlayerData.cpp:52: Cloud player-data.json unavailable
   0.748 Custom inputs active: 0
   0.749 Info Updater.cpp:749: Downloading https://updater.factorio.com/get-available-versions?username=Xelephant&token=<private>&apiVersion=2
   1.383 0 packages available to download (experimental updates enabled).
   1.389 Factorio initialised
   1.391 Info HttpSharedState.cpp:44: Downloading https://auth.factorio.com/api-login?api_version=2
   1.853 Info HttpSharedState.cpp:108: Status code: 200
   1.853 Info AuthServerConnector.cpp:165: Got token from auth server for username(Xelephant).
   1.856 Info ServerSynchronizer.cpp:27: nextHeartbeatSequenceNumber(0) initialized Synchronizer nextTickClosureTick(0).
   1.857 Info ServerMultiplayerManager.cpp:636: mapTick(-1) changing state from(Ready) to(PreparedToHostGame)
   1.858 Info ServerMultiplayerManager.cpp:636: mapTick(-1) changing state from(PreparedToHostGame) to(CreatingGame)
   1.878 Loading map C:\Users\Administrator\Desktop\FactorioMods2\saves\_autosave2.zip
   1.960 Info Scenario.cpp:152: Map version 0.14.9-1
   7.185 Checksum for script C:/Users/Administrator/Desktop/FactorioMods2/temp/currently-playing/control.lua: 900459546
   7.264 Info WindowsUDPSocket.cpp:61: Opening socket at port (27016)
   7.265 Hosting game at port 27016
   7.266 Info HttpSharedState.cpp:44: Downloading https://auth.factorio.com/generate-server-padlock
   7.362 Info HttpSharedState.cpp:108: Status code: 200
   7.363 Info AuthServerConnector.cpp:106: Obtained serverPadlock for serverHash (nd6ha5vF0Tlgsej1DUiCcwjrGqFgYTmf) from the auth server.
   7.364 Info ServerMultiplayerManager.cpp:636: mapTick(9055081) changing state from(CreatingGame) to(InGame)
   7.365 Info ServerRouter.cpp:592: Asking pingpong servers (pingpong1.factorio.com:34197, pingpong2.factorio.com:34197) for own address
   7.481 Info RemoteCommandProcessor.cpp:97: Starting RCON interface at port XXXXX
   7.500 Info ServerRouter.cpp:505: Own address is 213.202.212.228:27016
   7.914 Info ServerMultiplayerManager.cpp:565: Matching server connection resumed

[cube]

This problem is caused by Factorio packets from your machine being lost due to TTL running out (which looks like network problems on your machine). In 0.14.14 we will be forcing TTL to maximum just to be sure and ignoring this error with only a logged warning, so that Factorio should be able to recover if this problem appears only briefly.