Headless server crashes on save 15.37

[starbuck]

Hosting a headless server on Linux ver. 15.37 Whenever the game tries to autosave or I try to issue a manual save in cmd-line the server crashes. I'm running the server as a service and I've given the user appropriate privileges to read/write/modify content in the /opt/factorio directory.

I can turn auto-saves off and the server runs fine, but I'd like to have autosave/save working. Not sure what else to try

33.358 Info ServerMultiplayerManager.cpp:671: mapTick(10199290) changing state from(InGame) to(InGameSavingMap)
33.375 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(Ready) newState(ConnectedWaitingFo$
33.922 Info ServerMultiplayerManager.cpp:815: MapTick(10199290) Serving map(/opt/factorio/temp/mp-save-0.zip) for peer(1) size(8910048) crc$
33.922 Info ServerMultiplayerManager.cpp:671: mapTick(10199290) changing state from(InGameSavingMap) to(InGame)
33.972 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(ConnectedWaitingForMap) newState(C$
34.826 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(ConnectedDownloadingMap) newState($
35.405 Info ServerMultiplayerManager.cpp:755: mapTick(10199324) received stateChanged peerID(1) oldState(ConnectedLoadingMap) newState(Tryi$
35.501 Info ServerMultiplayerManager.cpp:755: mapTick(10199330) received stateChanged peerID(1) oldState(TryingToCatchUp) newState(WaitingF$
55.970 Error ParallelScenarioSaver.cpp:92: Saving scenario failed: Opening package /opt/factorio/saves/_autosave1.tmp.zip for writing failed
55.986 Error Util.cpp:62: Attempting to create notice box in headless mode. Message: 'Opening package /opt/factorio/saves/_autosave1.tmp.zip fo$
56.053 Info ServerMultiplayerManager.cpp:116: Disconnecting multiplayer connection.
56.053 Info ServerMultiplayerManager.cpp:671: mapTick(10200559) changing state from(InGame) to(DisconnectingScheduled)
56.065 Info ServerMultiplayerManager.cpp:140: Quitting multiplayer connection.
56.065 Info ServerMultiplayerManager.cpp:671: mapTick(-1) changing state from(DisconnectingScheduled) to(Closed)

[Loewchen]

Provide:

• complete log-file after a session with the issue
• last working save file

[starbuck]

Hello,

This is the complete current.log, attached is the save file. I've run chmod 755 /opt/factorio, i don't think i should need more, but maybe I'm wrong.

0.000 2017-12-01 21:53:40; Factorio 0.15.37 (build 30927, linux64, headless)
0.088 Operating system: Linux (LinuxMint 18.2)
0.088 Program arguments: "/opt/factorio/bin/x64/factorio" "--start-server-load-latest" "/opt/factorio/saves/_gamesave.zip" "--server-settings" "/opt/factorio/data/server-settings.json"
0.088 Read data path: /opt/factorio/data
0.088 Write data path: /opt/factorio
0.088 Binaries path: /opt/factorio/bin
0.096 System info: [CPU: Intel(R) Core(TM) i7-5930K CPU @ 3.50GHz, 12 cores, RAM: 15886MB]
0.096 Running in headless mode
0.099 Loading mod core 0.0.0 (data.lua)
0.107 Loading mod base 0.15.37 (data.lua)
0.175 Loading mod base 0.15.37 (data-updates.lua)
0.195 Checksum for core: 2904504744
0.195 Checksum of base: 1503927233
0.254 Info PlayerData.cpp:58: Local player-data.json available, timestamp 1512184647
0.254 Info PlayerData.cpp:65: Cloud player-data.json unavailable
0.255 Custom inputs active: 0
0.255 Info Updater.cpp:751: Downloading https://updater.factorio.com/get-availa ... iVersion=2
1.687 Some core updates would be reachable if experimental updates were enabled.
1.687 0 packages available to download (experimental updates disabled).
1.693 Factorio initialised
1.694 Info HttpSharedState.cpp:44: Downloading https://auth.factorio.com/api-login?api_version=2
2.329 Info HttpSharedState.cpp:111: Status code: 200
2.329 Info AuthServerConnector.cpp:171: Got token from auth server for username(starbuck).
2.329 Info ServerSynchronizer.cpp:28: nextHeartbeatSequenceNumber(0) initialized Synchronizer nextTickClosureTick(0).
2.329 Info ServerMultiplayerManager.cpp:671: mapTick(-1) changing state from(Ready) to(PreparedToHostGame)
2.329 Info ServerMultiplayerManager.cpp:671: mapTick(-1) changing state from(PreparedToHostGame) to(CreatingGame)
2.329 Loading map /opt/factorio/saves/_gamesave.zip: 9604420 bytes.
2.334 Loading Level.dat: 22691681 bytes.
2.338 Info Scenario.cpp:135: Map version 0.15.37-0
2.662 Info BlueprintLibrary.cpp:226: Loaded library shelves:
2.662 Info BlueprintLibrary.cpp:794: Game shelf: playerIndex = 65535, nextRecordID = 0; timestamp = 1511420421; records:
2.662 Info BlueprintLibrary.cpp:796: Player shelf: playerIndex = 0, nextRecordID = 0; timestamp = 1512182659; records:
2.662 Info BlueprintLibrary.cpp:796: Player shelf: playerIndex = 1, nextRecordID = 0; timestamp = 1512028196; records:
2.662 Info BlueprintLibrary.cpp:796: Player shelf: playerIndex = 2, nextRecordID = 0; timestamp = 1512182674; records:
2.704 Info BlueprintLibrary.cpp:49: Loaded external blueprint storage: playerIndex = 65535, nextRecordID = 0; timestamp = 1512194023; records:
2.704 Loading script.dat: 190 bytes.
2.705 Checksum for script /opt/factorio/temp/currently-playing/control.lua: 282129324
2.710 Info UDPSocket.cpp:27: Opening socket at (0.0.0.0:34197)
2.710 Hosting game at 0.0.0.0:34197
2.710 Info HttpSharedState.cpp:44: Downloading https://auth.factorio.com/generate-server-padlock-2
2.789 Info HttpSharedState.cpp:111: Status code: 200
2.789 Info AuthServerConnector.cpp:108: Obtained serverPadlock for serverHash (WcUgExWLim5M5BiztpE6A9Wk8YLwbQ5j) from the auth server.
2.789 Info ServerMultiplayerManager.cpp:671: mapTick(10199290) changing state from(CreatingGame) to(InGame)
2.789 Info ServerRouter.cpp:580: Asking pingpong servers (pingpong1.factorio.com:34197, pingpong2.factorio.com:34197) for own address
2.961 Info UDPSocket.cpp:39: Opening socket for broadcast
2.981 Error InterruptibleStdioStream.cpp:53: Reading stdin failed
3.299 Info ServerRouter.cpp:475: Own address is 72.193.220.36:34197
3.784 Info ServerMultiplayerManager.cpp:600: Matching server connection resumed
23.502 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(10.7.10.5:55383)
23.502 Info ServerRouter.cpp:562: Generated hmac(HZfTti55wnEdOqN5QH8tew==) and serverKey(Z1cgdoQ/H6qG67S6lmAZww==) for username(starbuck) differ. Generated from message(starbuck_Oz8d6jWmLplwt2DgK7jWZn2xx3E6hqvgEZWMLS2rASo=_171202031529).
23.502 Refusing connection for address (10.7.10.5:55383), username (starbuck). UserVerificationMismatch
24.037 ConnectionRequestReplyConfirm (type(ConnectionRequestReplyConfirm) ) from(10.7.10.5:64450)
24.037 Info ServerRouter.cpp:390: Replying to connectionRequest for address(10.7.10.5:64450).
24.037 Info ServerSynchronizer.cpp:552: nextHeartbeatSequenceNumber(629) adding peer(1)
24.054 Info ServerMultiplayerManager.cpp:671: mapTick(10199290) changing state from(InGame) to(InGameSavingMap)
24.071 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(Ready) newState(ConnectedWaitingForMap)
24.533 Info ServerMultiplayerManager.cpp:815: MapTick(10199290) Serving map(/opt/factorio/temp/mp-save-0.zip) for peer(1) size(8910048) crc(3075868281)
24.533 Info ServerMultiplayerManager.cpp:671: mapTick(10199290) changing state from(InGameSavingMap) to(InGame)
24.584 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(ConnectedWaitingForMap) newState(ConnectedDownloadingMap)
25.420 Info ServerMultiplayerManager.cpp:755: mapTick(10199290) received stateChanged peerID(1) oldState(ConnectedDownloadingMap) newState(ConnectedLoadingMap)
26.118 Info ServerMultiplayerManager.cpp:755: mapTick(10199331) received stateChanged peerID(1) oldState(ConnectedLoadingMap) newState(TryingToCatchUp)
26.270 Info ServerMultiplayerManager.cpp:755: mapTick(10199340) received stateChanged peerID(1) oldState(TryingToCatchUp) newState(WaitingForCommandToStartSendingTickClosures)
26.271 Info GameActionHandler.cpp:3320: MapTick (10199340) processed PlayerJoinGame peerID(1) playerIndex(0) mode(connect )
26.349 Info ServerMultiplayerManager.cpp:755: mapTick(10199345) received stateChanged peerID(1) oldState(WaitingForCommandToStartSendingTickClosures) newState(InGame)
137.276 Warning WriteFileGuard.cpp:44: Writing /opt/factorio/saves/_autosave5.zip failed; previous version (if any) should still be available
137.276 Error ParallelScenarioSaver.cpp:92: Saving scenario failed: Opening package /opt/factorio/saves/_autosave5.tmp.zip for writing failed
137.292 Error Util.cpp:62: Attempting to create notice box in headless mode. Message: 'Opening package /opt/factorio/saves/_autosave5.tmp.zip for writing failed'
137.357 Info ServerMultiplayerManager.cpp:116: Disconnecting multiplayer connection.
137.357 Info ServerMultiplayerManager.cpp:671: mapTick(10206001) changing state from(InGame) to(DisconnectingScheduled)
137.368 Info ServerMultiplayerManager.cpp:140: Quitting multiplayer connection.
137.368 Info ServerMultiplayerManager.cpp:671: mapTick(-1) changing state from(DisconnectingScheduled) to(Closed)
137.369 Info HttpSharedState.cpp:44: Downloading https://multiplayer.factorio.com/remove-game/369282
137.448 Info HttpSharedState.cpp:111: Status code: 200
137.448 Info UDPSocket.cpp:206: Closing socket
137.448 Info UDPSocket.cpp:236: Socket closed
137.448 Info UDPSocket.cpp:206: Closing socket
137.486 Info UDPSocket.cpp:206: Closing socket
137.486 Info UDPSocket.cpp:236: Socket closed
137.486 Goodbye

[Loewchen]

"--start-server-load-latest" "/opt/factorio/saves/_gamesave.zip"

Makes no sense to me, either you load the latest or you load a specific one, but I don't see how it would cause the error.

Try if this crashes as well:

Code: Select all

--start-server /opt/factorio/saves/_gamesave.zip

[starbuck]

Changed that in the service, still crashed

[starbuck]

This can be closed. I forgot to -R the chmod and it was not making the directories inside /opt/factorio wrx.