search

R2Northstar / Northstar

Repo for packaged Northstar releases
https://northstar.tf/
MIT License
1.69k stars 129 forks source link

Server failing to let new players in after some time. #295

Open GeckoEidechse opened 2 years ago

GeckoEidechse commented 2 years ago

I've received a report where a server would still have slots open but not allow new players:

Log snippet on client trying to connect:

...
[2022-06-18 01:27:32.305] [info] [UI SCRIPT] menu_LobbyMenu menu closed
[2022-06-18 01:27:32.306] [info] [UI SCRIPT] menu_ServerBrowserMenu menu opened
[2022-06-18 01:27:32.307] [info] [CLIENT SCRIPT] Interpolating menu camera to: KNOWLEDGEBASE_MAIN
[2022-06-18 01:27:32.307] [info] Requesting server list from https://northstar.tf
[2022-06-18 01:27:32.495] [info] Got 151 servers
[2022-06-18 01:27:37.317] [info] [UI SCRIPT] trying to authenticate with server [US-EAST] Iniquity's Attrition 6v6 with password 
[2022-06-18 01:27:37.518] [info] Attempting authentication with server of id "463647c5ed9c2da64775df3b0e00ccca"
[2022-06-18 01:27:37.938] [info] [UI SCRIPT] UICodeCallback_LevelShutdown: mp_lobby
[2022-06-18 01:27:37.938] [info] [UI SCRIPT] Hiding all matchmaking elems due to UpdateMatchmakingStatus thread ending
[2022-06-18 01:27:37.939] [info] [UI SCRIPT] menu_ServerBrowserMenu menu closed
[2022-06-18 01:27:37.939] [info] [UI SCRIPT] menu_LobbyMenu menu closed
[2022-06-18 01:27:37.939] [info] [UI SCRIPT] menu_MainMenu menu opened
[2022-06-18 01:27:37.939] [info] [UI SCRIPT] =========== Show: MainMenuPanel ===========
[2022-06-18 01:27:37.940] [info] [UI SCRIPT] SAVEGAME try is valid savegame
[2022-06-18 01:27:37.940] [info] [UI SCRIPT] SAVEGAME is valid  savegame
[2022-06-18 01:27:37.966] [info] DestroyVM CLIENT 0x9309b47300
[2022-06-18 01:27:37.972] [info] [UI SCRIPT] UICodeCallback_LevelLoadingStarted: 
[2022-06-18 01:27:37.981] [info] Player GeckoEidechse disconnected: "Disconnect by user."
[2022-06-18 01:27:37.981] [info] Player GeckoEidechse disconnected: "Disconnect by user."
[2022-06-18 01:27:37.981] [warning] attempted to write pdata of size 0!
...

Log on server:

...
[2022-06-17 19:22:46.507] [info] [SERVER SPEW_MESSAGE] SERVER: Lunge_SetTargetEntity(): Setting lunge target to (null)
[2022-06-17 19:22:46.507] [info] [SERVER SPEW_MESSAGE] Setting player "player ZZZZZ_01 [5]" predicted first person proxy model to "" (class "spectator")
[2022-06-17 19:22:46.508] [info] [SERVER SCRIPT] pilot primary skin/camo 1 17
[2022-06-17 19:22:46.508] [info] [SERVER SCRIPT] pilot secondary skin/camo 0 0
[2022-06-17 19:22:46.509] [info] [SERVER SCRIPT] pilot weapon3 skin/camo 1 30
[2022-06-17 19:22:46.509] [info] [SERVER SPEW_MESSAGE] Setting player "player ZZZZZ_01 [5]" predicted first person proxy model to "models/weapons/arms/pov_pilot_light_jester_f.mdl" (class "pilot_nomad_female")
[2022-06-17 19:22:46.510] [info] [SERVER SCRIPT] pilot primary skin/camo 1 17
[2022-06-17 19:22:46.510] [info] [SERVER SCRIPT] pilot secondary skin/camo 0 0
[2022-06-17 19:22:46.510] [info] [SERVER SCRIPT] pilot weapon3 skin/camo 1 30
[2022-06-17 19:22:47.015] [info] [SERVER SPEW_MESSAGE] Setting player "player ZZZZZ_02 [7]" predicted first person proxy model to "" (class "spectator")
[2022-06-17 19:22:47.015] [info] [SERVER SCRIPT] respawn delay 0
[2022-06-17 19:22:47.509] [info] [SERVER SPEW_MESSAGE] SERVER: Lunge_SetTargetEntity(): Setting lunge target to (null)
[2022-06-17 19:22:47.510] [info] [SERVER SPEW_MESSAGE] Setting player "player ZZZZZ_02 [7]" predicted first person proxy model to "" (class "spectator")
[2022-06-17 19:22:47.511] [info] [SERVER SCRIPT] pilot primary skin/camo 0 0
[2022-06-17 19:22:47.511] [info] [SERVER SCRIPT] pilot secondary skin/camo 1 30
[2022-06-17 19:22:47.511] [info] [SERVER SCRIPT] pilot weapon3 skin/camo 0 0
[2022-06-17 19:22:47.511] [info] [SERVER SPEW_MESSAGE] Setting player "player ZZZZZ_02 [7]" predicted first person proxy model to "models/weapons/arms/pov_pilot_medium_geist_f.mdl" (class "pilot_grapple_female")
[2022-06-17 19:22:47.512] [info] [SERVER SCRIPT] pilot primary skin/camo 0 0
[2022-06-17 19:22:47.512] [info] [SERVER SCRIPT] pilot secondary skin/camo 1 30
[2022-06-17 19:22:47.512] [info] [SERVER SCRIPT] pilot weapon3 skin/camo 0 0
[2022-06-17 19:22:48.969] [info] [SERVER SCRIPT] AttackerShouldTriggerReplay(): Doing a replay because the attacker is a player.
[2022-06-17 19:22:49.813] [info] [SERVER SCRIPT] [AUTOBALANCE] Teams are balanced (IMC: 4, MILITIA: 4)
[2022-06-17 19:23:04.392] [info] Player "XXXXX_01" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:23:05.733] [info] Player "XXXXX_02" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:24:02.428] [info] Player "XXXXX_03" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:24:06.699] [info] Player "XXXXX_02" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:24:20.903] [info] Player "XXXXX_04" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:24:34.977] [info] Player "XXXXX_03" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:24:42.763] [info] Player "XXXXX_05" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:25:01.153] [info] Player "XXXXX_06" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:25:18.204] [info] Player "XXXXX_05" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:25:26.040] [info] Player "XXXXX_06" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:25:44.125] [info] Player "XXXXX_07" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:26:24.450] [info] Player "XXXXX_07" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:26:34.360] [info] Player "XXXXX_08" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:27:06.481] [info] Player "XXXXX_09" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:27:43.503] [info] Player "<THE_ABOVE_CLIENT>" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:27:56.948] [info] Player "XXXXX_04" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:28:19.428] [info] Player "XXXXX_10" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:28:20.492] [info] Player "XXXXX_11" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:28:28.219] [info] Player "XXXXX_12" with UID "YYYYYYYYYYYYYY" requested to join
[2022-06-17 19:28:36.076] [info] Exiting due to console close...

(Not that I have manually replaced player names and UIDs. <THE_ABOVE_CLIENT> refers to the log of the above client.)

I have a full copy of the server log stored locally if needed.

 

Apparently console commands no longer work either, once it happens.

 

Mods used on the server: image

Given the large number of mods there's a decent chance the issue is caused by one of the mods but that's not confirmed yet.

barnabwhy commented 2 years ago

first off, my auto balance mod hasn't been updated since like 1.5 or something. i have heard of it causing issues before (although it seems to be working fine from the logs)