headless server - download map stops

[EoRaptor]

I have setup a headless linux server.
I can connect through either LAN or the public game-browser.
A second person connects without problems through either steam-list or the public game-browser without problems as well.

A 3rd person trying to connect through the public-game browser is disconnected when only partially through the download of the map.
Each time that is at 1.9MB of the download. The server simply stops and shows as not-responding to that person and he is dropped from the game.

The logging shows the ServerMultiplayerManager state as ConnectedWaitingForMap and later as ConnectedDownloadingMap.
MapDownloadingProgressUpdate from peer is processed, but after a short period, the peer is disconnected.

Any idea in what direction I have to look in order to solve this issue?

Regards,

[Loewchen]

Try reducing the download speed in the server settings.

[EoRaptor]

Thanks for the reply!
Lowering that setting worked.

I must admit that i was skeptic on the answer till i tested that and seen that it worked.


I am curious to know why that works like this. Do you know the answer to the why?

Regards,

[Loewchen]

The servers upload speed is limited and it gets congested uploading the map, so the packets sent to the connected player get dropped. Reducing the upload speed avoids the congestion.

[bigmond]

Just some additional information since I am the player that was having trouble connecting.

I get to 1.8-1.9MB downloaded and the download stops and I get booted.

This happens on any server. I have tried modded and unmodded. On a brand new map I can connectr fine but once the map grows over a couple MB It stops cloase to 2MB and kicks me.

I have done a resinstall of factorio including clearing the appdata folder.

• Connect to modded headless +server Using browse games - Connection stops around 2MB
• Connect to vanilla headless server - Connection stops around 2MB
• Connect to headless server using IP address on LAN (default settings, imported large map.) - Downloads close to 10MB/s and downloads successfully
• Connect to headless server that is shown on LAN using browse LAN games - Downloads close to 10MB/s and downloads succefully
• Connect to headless server using IP address over wan. - Stops at clost to 2MB then disconnects
• Connect to headless server from public games list. - Stops at clost to 2MB then disconnects
• Tried several randomly selsected unmodded servers from public games list, stops close to 2MB then disconnects.
• Connect to player hosted game from public games list - Download stutters, Downloads at 1MB/s initially, stops and drops to 0, waits for several seconds and then repeats.

This is the log file when I get disconnected trying to connect

Code: Select all

 
    0.001 2020-06-17 14:23:28; Factorio 0.18.32 (build 52799, win64, steam)
   0.001 Operating system: Windows 10 (version 2004) 
   0.002 Program arguments: "C:\Program Files (x86)\Steam\steamapps\common\Factorio\bin\x64\Factorio.exe" "--wait-to-close" "14696" "--mp-connect" "xxx.xxx.xxx.16:34197" 
   0.002 Read data path: C:/Program Files (x86)/Steam/steamapps/common/Factorio/data
   0.002 Write data path: C:/Users/BigMonD/AppData/Roaming/Factorio [94606/226357MB]
   0.002 Binaries path: C:/Program Files (x86)/Steam/steamapps/common/Factorio/bin
   0.017 System info: [CPU: AMD FX(tm)-8350 Eight-Core Processor, 8 cores, RAM: 6278/16121 MB, page: 8073/35449 MB, virtual: 4327/134217727 MB, extended virtual: 0 MB]
   0.018 Display options: [FullScreen: 1] [VSync: 1] [UIScale: automatic (100.0%)] [Native DPI: 1] [Screen: 255] [Special: lmw] [Lang: en]
   0.030 Available displays: 2
   0.031  [1]: \\.\DISPLAY2 - NVIDIA GeForce GTX 1060 3GB {0x05, [0,0], 1920x1080, 32bit, 60Hz}
   0.031  [0]: \\.\DISPLAY1 - NVIDIA GeForce GTX 1060 3GB {0x01, [-1920,0], 1920x1080, 32bit, 60Hz}
   0.166 [Direct3D11] Display: 0, Output: 0, DisplayAdapter: 0, RenderingAdapter: 0; d3dcompiler_47.dll
   0.168 Verbose GraphicsInterfaceDX11.cpp:263: DXGI 1.5 detected, Allow tearing is supported
   0.171  Adapter [0]: NVIDIA GeForce GTX 1060 3GB {10de-1c02} (26.21.14.4614)
   0.174  Adapter [1]: Microsoft Basic Render Driver {1414-8c} (10.0.19041.84)
   0.387 Initialised Direct3D[0]: NVIDIA GeForce GTX 1060 3GB; id: 10de-1c02; driver: nvldumdx.dll 26.21.14.4614
   0.387   D3D Feature Level: 11.1, DXGI 1.5+, SwapChain: 3,flip-discard,-,-,-,none
   0.387   [Local Video Memory] Budget: 2539MB, CurrentUsage: 2MB, Reservation: 0/1344MB
   0.388   [Non-Local Vid.Mem.] Budget: 7401MB, CurrentUsage: 0MB, Reservation: 0/3828MB
   0.388   Tiled resources: Tier 2
   0.388   Unified Memory Architecture: No
   0.388   BGR 565 Supported: Yes
   0.388   MaximumFrameLatency: 3, GPUThreadPriority: 0
   0.388 Graphics settings preset: very-high
   0.388   Dedicated video memory size 2988 MB
   0.453 Verbose PipelineStateObject.cpp:85: Time to load shaders: 0.062873 seconds.
   0.459 Desktop composition is active.
   0.459 Graphics options: [Graphics quality: high] [Video memory usage: all] [Light scale: 25%] [DXT: high-quality] [Color: 32bit]
   0.459                   [Max threads (load/render): 32/8] [Max texture size: 0] [Tex.Stream.: 0] [Rotation quality: normal] [Other: STDCWT] [B:0,C:0,S:100]
   0.583 DSound: Starting _dsound_update thread
   0.583 DSound: Enter _dsound_update; tid=15872
   0.830 Info ModManager.cpp:253: Found duplicate mod DeathMarkers, using higher version (0.3.1 > 0.3.0).
   0.885 Info ModManager.cpp:253: Found duplicate mod space-exploration, using higher version (0.3.81 > 0.3.77).
   0.970 Verbose PipelineStateObject.cpp:77: Time to load shaders in background: 0.517573 seconds.
   0.982 Info ModManager.cpp:253: Found duplicate mod space-exploration-postprocess, using higher version (0.3.19 > 0.3.18).
   1.027 Info ModManager.cpp:253: Found duplicate mod train-pubsub, using higher version (0.6.19 > 0.6.18).
   1.035 Loading mod core 0.0.0 (data.lua)
   1.223 Loading mod base 0.18.32 (data.lua)
   1.776 Loading mod base 0.18.32 (data-updates.lua)
   2.048 Checksum for core: 533635165
   2.048 Checksum of base: 2402425971
   2.390 Prototype list checksum: 156825909
   2.393 Verbose ModManager.cpp:554: Time to load mods: 1.68821
   2.487 Loading sounds...
   2.698 Info PlayerData.cpp:70: Local player-data.json unavailable
   2.698 Info PlayerData.cpp:73: Cloud player-data.json available, timestamp 1592399501
   2.975 Initial atlas bitmap size is 16384
   3.036 Created atlas bitmap 16384x16368 [none]
   3.042 Created atlas bitmap 16384x11428 [none]
   3.043 Created atlas bitmap 8192x3736 [decal]
   3.046 Created atlas bitmap 16384x5248 [low-object, linear-minification]
   3.047 Created atlas bitmap 8192x3760 [mipmap, linear-minification, linear-magnification, linear-mip-level]
   3.048 Created atlas bitmap 16384x5776 [terrain, mipmap, linear-minification, linear-mip-level]
   3.049 Created atlas bitmap 4096x2848 [terrain-effect-map, mipmap, linear-minification, linear-mip-level]
   3.049 Created atlas bitmap 4096x1600 [smoke, mipmap, linear-minification, linear-magnification]
   3.050 Created atlas bitmap 4096x3104 [mipmap]
   3.051 Created atlas bitmap 4096x2144 [icon, not-compressed, mipmap, linear-minification, linear-magnification, linear-mip-level]
   3.051 Created atlas bitmap 2048x192 [icon-background, not-compressed, mipmap, linear-minification, linear-magnification, linear-mip-level, ]
   3.051 Created atlas bitmap 4096x2652 [alpha-mask]
   3.056 Created atlas bitmap 16384x14748 [shadow, linear-magnification, alpha-mask]
   3.057 Created atlas bitmap 8192x2352 [shadow, mipmap, linear-magnification, alpha-mask]
   3.064 Verbose TextureProcessor.cpp:1140: GPU accelerated compression test: Time 7.408 ms; YCoCg_DXT PSNR: 35.83, BC3 PSNR: 33.82
   3.064 Texture processor created (2048). GPU accelerated compression Supported: yes, Enabled: yes/yes. Test passed. YCoCgDXT PSNR: 35.83, BC3 PSNR: 33.82
   4.337 Parallel Sprite Loader initialized (threads: 7)
  17.098 Sprites loaded
  17.156 Generated mipmaps (4) for atlas [3] of size 16384x5248   
  17.178 Generated mipmaps (3) for atlas [4] of size 8192x3760   
  17.223 Generated mipmaps (3) for atlas [5] of size 16384x5776   
  17.234 Generated mipmaps (3) for atlas [6] of size 4096x2848   
  17.245 Generated mipmaps (3) for atlas [7] of size 4096x1600   
  17.296 Generated mipmaps (3) for atlas [8] of size 4096x3104   
  17.308 Generated mipmaps (5) for atlas [9] of size 4096x2144   
  17.320 Generated mipmaps (3) for atlas [13] of size 8192x2352   
  17.332 Custom mipmaps uploaded.
  17.332 Verbose AtlasSystem.cpp:909: Atlas memory size: 1125.37MB; 0.00MB (virtual)
  17.332 Verbose AtlasSystem.cpp:910: Size of sprites outside of atlas: 0.13MB
  17.442 Factorio initialised
  17.445 Joining game IP ADDR:({xxx.xxx.xxx.16:34197})
  17.445 Info UDPSocket.cpp:33: Opening socket
  17.447 Verbose RouterBase.cpp:60: Started router thread.
  17.447 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Ready) to(Connecting)
  17.450 Verbose SteamContext.cpp:553: SteamUserStats initialized.
  17.668 Connection refused
  17.669 Info ClientMultiplayerManager.cpp:202: Quitting multiplayer connection.
  17.669 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Connecting) to(Disconnected)
  17.670 Info HttpSharedState.cpp:54: Downloading https://auth.factorio.com/generate-user-server-key-2?api_version=4
  18.162 Info AuthServerConnector.cpp:97: Received key from auth server.
  18.163 Verbose RouterBase.cpp:82: Finishing router thread.
  18.164 Info UDPSocket.cpp:218: Closing socket
  18.164 Info UDPSocket.cpp:248: Socket closed
  18.164 Joining game IP ADDR:({xxx.xxx.xxx.16:34197})
  18.164 Info UDPSocket.cpp:33: Opening socket
  18.165 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Ready) to(Connecting)
  18.165 Verbose RouterBase.cpp:60: Started router thread.
  18.437 Info ClientSynchronizer.cpp:35: Initialized Synchronizer local peer(1) latency(32).
  18.437 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(Connecting) to(ConnectedWaitingForMap)
  18.437 Info ClientRouter.cpp:221: ConnectionAccepted
  18.736 Info ClientMultiplayerManager.cpp:750: Received mapReadyForDownload
  18.736 Downloading file C:\Users\BigMonD\AppData\Roaming\Factorio\temp\mp-download.zip (4692138 B, 9329 blocks)
  18.738 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(ConnectedWaitingForMap) to(ConnectedDownloadingMap)
  46.969 Warning ClientSynchronizer.cpp:89: nextHeartbeatSequenceNumber(562865385) server wants a heartbeat(562864580) that we don't have.
  47.535 Warning ClientSynchronizer.cpp:89: nextHeartbeatSequenceNumber(562865402) server wants a heartbeat(562864580) that we don't have.
  47.670 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(ConnectedDownloadingMap) to(WaitingForUserToSaveOrQuitAfterServerLeft)
  47.819 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911211) outside latency window [2910411, 2911211)
  47.819 Info UnparsedNetworkMessage.cpp:102: Message data: 27 00 eb 6b 2c 00
  47.836 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911212) outside latency window [2910411, 2911211)
  47.836 Info UnparsedNetworkMessage.cpp:102: Message data: 27 00 ec 6b 2c 00
  47.886 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911213) outside latency window [2910411, 2911211)
  47.886 Info UnparsedNetworkMessage.cpp:102: Message data: 07 10 ed 6b 2c 00 01 0b f9 07 00
  47.918 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911214) outside latency window [2910411, 2911211)
  47.918 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 ee 6b 2c 00
  47.936 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911215) outside latency window [2910411, 2911211)
  47.936 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 ef 6b 2c 00
  47.986 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911216) outside latency window [2910411, 2911211)
  47.986 Info UnparsedNetworkMessage.cpp:102: Message data: 27 10 f0 6b 2c 00 01 0b fa 07 00
  48.018 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911217) outside latency window [2910411, 2911211)
  48.018 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 f1 6b 2c 00
  48.052 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911218) outside latency window [2910411, 2911211)
  48.052 Info UnparsedNetworkMessage.cpp:102: Message data: 27 00 f2 6b 2c 00
  48.086 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911219) outside latency window [2910411, 2911211)
  48.086 Info UnparsedNetworkMessage.cpp:102: Message data: 27 10 f3 6b 2c 00 01 0b fb 07 00
  48.118 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911220) outside latency window [2910411, 2911211)
  48.119 Info UnparsedNetworkMessage.cpp:102: Message data: 27 01 f4 6b 2c 00 01 c4 a1 8c 21
  48.153 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911221) outside latency window [2910411, 2911211)
  48.153 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 f5 6b 2c 00
  48.186 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911222) outside latency window [2910411, 2911211)
  48.186 Info UnparsedNetworkMessage.cpp:102: Message data: 07 10 f6 6b 2c 00 01 0b fc 07 00
  48.218 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911223) outside latency window [2910411, 2911211)
  48.218 Info UnparsedNetworkMessage.cpp:102: Message data: 27 00 f7 6b 2c 00
  48.252 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911224) outside latency window [2910411, 2911211)
  48.252 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 f8 6b 2c 00
  48.285 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911225) outside latency window [2910411, 2911211)
  48.285 Info UnparsedNetworkMessage.cpp:102: Message data: 07 10 f9 6b 2c 00 01 0b fd 07 00
  48.319 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911226) outside latency window [2910411, 2911211)
  48.319 Info UnparsedNetworkMessage.cpp:102: Message data: 07 00 fa 6b 2c 00
  48.351 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911227) outside latency window [2910411, 2911211)
  48.351 Info UnparsedNetworkMessage.cpp:102: Message data: 07 10 fb 6b 2c 00 01 0b fe 07 00
  48.385 Info UnparsedNetworkMessage.cpp:91: Invalid packet (type ServerToClientHeartbeat) received from IP ADDR:({xxx.xxx.xxx.16:34197}): heartbeat sequence number (2911228) outside latency window [2910411, 2911211)
  48.386 Info UnparsedNetworkMessage.cpp:102: Message data: 27 10 fc 6b 2c 00 01 01 01 07 00
  50.138 Info ClientMultiplayerManager.cpp:202: Quitting multiplayer connection.
  50.138 Info ClientMultiplayerManager.cpp:581: UpdateTick(4294967295) changing state from(WaitingForUserToSaveOrQuitAfterServerLeft) to(Disconnected)
  50.139 Verbose RouterBase.cpp:82: Finishing router thread.
  50.140 Info UDPSocket.cpp:218: Closing socket
  50.140 Info UDPSocket.cpp:248: Socket closed
  52.268 Quitting: user-quit.
  52.407 DSound: Stopping voice
  52.407 DSound: Joining thread
  52.410 DSound: Exit _dsound_update; tid=15872
  52.410 DSound: Waiting for voice to stop ... signaled
  52.411 DSound: Joined thread
  52.411 DSound: Destroying thread
  52.411 DSound: Thread destroyed
  52.411 DSound: Releasing buffer
  52.411 DSound: Voice stopped
  52.411 DSound: Deallocating voice
  52.411 DSound: Deallocated voice
  52.540 Steam API shutdown.
  52.545 Goodbye