Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Server does not seem to start properly with proton launcher inside podman #103

Open
1 task done
red15 opened this issue Nov 8, 2024 · 5 comments
Open
1 task done
Labels
bug 🐞 Something isn't working

Comments

@red15
Copy link

red15 commented Nov 8, 2024

Is there an existing issue for this?

  • I have searched the existing issues

Used image version

d97d8c0bb6e0

Used docker compose file or docker command

podman pod create enshrouded # Make a pod to contain both tailscale and enshrouded server containers
podman create --pod enshrouded --name tailscale docker.io/tailscale/tailscale # Has plenty more options irrelevant for this bug
podman volume create ensh # For storing the binary data in a persistent volume
podman create --pod enshrouded --name server -v ensh:/opt/enshrouded -e SERVER_QUERYPORT=15637 -e SERVER_*... -e UPDATE_CRON="..." docker.io/mornedhels/enshrouded-server # Trimmed options here for readability

What you expected to see, versus what you actually saw

The process was started but any network queries seemed not to be answered. I had tcpdump confirm the UDP query packages came in but never got a reply.

Reading the repo I found the original Dockerfile which referenced using wine so I exec into the container and ran the wine setup commands and finally did an apt install wine-stable and edited the /usr/local/etc/enshrouded/enshrouded-server script and replaced the proton runinprefix -> wine.

Starting the container then I saw pretty much the same output as before with proton but now the network did respond properly.

While running the server and joining I did get some possible performance degradation warnings from the game client when 2 players were connected but possibly this is due to limited CPU performance inside the VM where I ran the container.

Logs from the container

Bad startup

INFO - Creating server folders (save, logs, backup)                                                                                                                                                                                            
INFO - Setting uid:gid of enshrouded to 4711:4711                                                                      
usermod: no changes                                                                                                                                                                                                                            
INFO - Setting up syslogd - logging to stdout                                                                                                                                                                                                  
2024-11-08 07:40:58,745 INFO Included extra file "/usr/local/etc/supervisor/conf.d/syslog.conf" during parsing
2024-11-08 07:40:58,746 INFO Set uid to user 0 succeeded                                                                                                                                                                                       
2024-11-08 07:40:58,758 INFO RPC interface 'supervisor' initialized                                                                                                                                                                            
2024-11-08 07:40:58,758 INFO supervisord started with pid 1                                                                                                                                                                                    
2024-11-08 07:40:59,762 INFO spawned: 'rsyslogd' with pid 16                                        
2024-11-08 07:40:59,766 INFO spawned: 'crond' with pid 17                                                                                                                                                                                      
2024-11-08 07:40:59,769 INFO spawned: 'enshrouded-bootstrap' with pid 18                                                                                                                                                                       
2024-11-08 07:40:59.784 rsyslogd: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.2312.0 try https://www.rsyslog.com/e/2307 ]
2024-11-08 07:40:59.784 rsyslogd: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="16" x-info="https://www.rsyslog.com"] start
2024-11-08 07:40:59,785 INFO success: enshrouded-bootstrap entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2024-11-08 07:40:59.799 supervisord: enshrouded-bootstrap INFO - Running enshrouded-bootstrap                  
2024-11-08 07:41:00.619 supervisord: enshrouded-bootstrap Defaulting to user installation because normal site-packages is not writeable
2024-11-08 07:41:00.715 supervisord: enshrouded-bootstrap Requirement already satisfied: python-a2s==1.3.0 in ./.local/lib/python3.12/site-packages (1.3.0)
2024-11-08 07:41:01,198 INFO success: rsyslogd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)                
2024-11-08 07:41:01,198 INFO success: crond entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)                   
2024-11-08 07:41:01,204 INFO spawned: 'enshrouded-updater' with pid 161             
2024-11-08 07:41:01,205 INFO success: enshrouded-updater entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)                                                                                                         
2024-11-08 07:41:01.206 supervisord: enshrouded-bootstrap enshrouded-updater: started                                                                                                                                                          
2024-11-08 07:41:01.223 supervisord: enshrouded-updater INFO - Running enshrouded-updater        
2024-11-08 07:41:01,245 INFO exited: enshrouded-bootstrap (exit status 0; expected)
2024-11-08 07:41:01.245 supervisord: enshrouded-bootstrap INFO - Bootstrap complete
2024-11-08 07:41:01.338 supervisord: enshrouded-updater INFO - Enshrouded server is already the latest version
2024-11-08 07:41:01.602 supervisord: enshrouded-updater INFO - Enshrouded server is not running - starting
2024-11-08 07:41:01,821 INFO spawned: 'enshrouded-server' with pid 175
2024-11-08 07:41:01.858 supervisord: enshrouded-server INFO - Running enshrouded-server
2024-11-08 07:41:02.063 supervisord: enshrouded-server fsync: up and running.
2024-11-08 07:41:07,084 INFO reaped unknown pid 184 (exit status 0)
2024-11-08 07:41:08.410 supervisord: enshrouded-server 00c8:err:kerberos:kerberos_LsaApInitializePackage no Kerberos support, expect problems
2024-11-08 07:41:09.680 supervisord: enshrouded-server GetTimerResolution 0: 1,000 ( 1,000 - 15,625 ) us
2024-11-08 07:41:09.680 supervisord: enshrouded-server SetTimerResolution 0: 1,000 us
2024-11-08 07:41:09.680 supervisord: enshrouded-server GetTimerResolution 0: 1,000 ( 1,000 - 15,625 ) us
2024-11-08 07:41:09.763 supervisord: enshrouded-server [os] Started thread 0x0000000002236a68 (MessageSystem) with stack range (0x000000000c0a0000-0x000000000c1a0000 size:1,048,576)
2024-11-08 07:41:09.763 supervisord: enshrouded-server [os] Started thread 0x00000000024caa90 (Task-default02) with stack range (0x000000000c1a0000-0x000000000c5a0000 size:4,194,304)
2024-11-08 07:41:09.766 supervisord: enshrouded-server [os] Started thread 0x0000000002236938 (NetworkSystem) with stack range (0x0000000001ca0000-0x0000000001da0000 size:1,048,576)
2024-11-08 07:41:09.777 supervisord: enshrouded-server [os] Started thread 0x00000000023ca950 (Task-default03) with stack range (0x000000000c5a0000-0x000000000c9a0000 size:4,194,304)
2024-11-08 07:41:09.790 supervisord: enshrouded-server [os] Started thread 0x00000000022ca7e8 (Task-default04) with stack range (0x000000000c9a0000-0x000000000cda0000 size:4,194,304)
2024-11-08 07:41:09.800 supervisord: enshrouded-server [os] Started thread 0x00000000028cb810 (Task-background00) with stack range (0x000000000cda0000-0x000000000d1a0000 size:4,194,304)
2024-11-08 07:41:09.813 supervisord: enshrouded-server [os] Started thread 0x0000000002acbcd0 (Task-background02) with stack range (0x000000000d5a0000-0x000000000d9a0000 size:4,194,304)
2024-11-08 07:41:09.820 supervisord: enshrouded-server [os] Started thread 0x00000000028cb948 (Task-background01) with stack range (0x000000000d1a0000-0x000000000d5a0000 size:4,194,304)
2024-11-08 07:41:09.823 supervisord: enshrouded-server CpuInfo:
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Type:      Intel
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Vendor:    'GenuineIntel'
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Brand:     'Intel(R) Xeon(R) Gold 6240 CPU @ 2.60GHz'
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Cpus:      4
2024-11-08 07:41:09.823 supervisord: enshrouded-server         Perf:  4 1111
2024-11-08 07:41:09.823 supervisord: enshrouded-server         Effi:  0 0
2024-11-08 07:41:09.823 supervisord: enshrouded-server     CacheLine: 64
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Simd:      SSE2,SSE3,SSSE3,SSE41,SSE42,AVX,AVX2
2024-11-08 07:41:09.823 supervisord: enshrouded-server     Other:     FMA,BMI1,BMI2,F16C,CTSC,AES,RDRAND
2024-11-08 07:41:09.826 supervisord: enshrouded-server MemoryInfo:
2024-11-08 07:41:09.826 supervisord: enshrouded-server     PhysTotal:   16,771,219,456
2024-11-08 07:41:09.826 supervisord: enshrouded-server     PhysAvail:   13,599,809,536
2024-11-08 07:41:09.826 supervisord: enshrouded-server     SwapTotal:   25,361,154,048
2024-11-08 07:41:09.826 supervisord: enshrouded-server     SwapAvail:   22,189,203,456
2024-11-08 07:41:09.826 supervisord: enshrouded-server OsSystemInfo:
2024-11-08 07:41:09.826 supervisord: enshrouded-server     ProductName:    'Windows 10 Pro'
2024-11-08 07:41:09.826 supervisord: enshrouded-server     DisplayVersion: '21H1'
2024-11-08 07:41:09.826 supervisord: enshrouded-server     Version:        10.0 (19043)
2024-11-08 07:41:09.826 supervisord: enshrouded-server 'gameSettings' will not be applied Preset is not set to 'Custom' 
2024-11-08 07:41:09.833 supervisord: enshrouded-server [holistic] Backup log to '/opt/enshrouded/server/logs/backup/enshrouded_server_2024-11-08T07-41-09.log'.
2024-11-08 07:41:09.833 supervisord: enshrouded-server [os] Started thread 0x0000000002acdd08 (BackgroundTask) with stack range (0x000000000d9b0000-0x000000000dab0000 size:1,048,576)
2024-11-08 07:41:09.835 supervisord: enshrouded-server [enshrouded] Create logfile
2024-11-08 07:41:09.837 supervisord: enshrouded-server enshrouded_server(detached HEAD) - version a19b06956a82d073048ab0121d6ced02ecc5d3b1 (master)
2024-11-08 07:41:09.838 supervisord: enshrouded-server CPUs:
2024-11-08 07:41:09.838 supervisord: enshrouded-server  Idx   Id  Group  LogIdx  CoreIdx  LLCIdx  NumaIdx  EffClass
2024-11-08 07:41:09.839 supervisord: enshrouded-server   0   256    0       0        0       3       0        0
2024-11-08 07:41:09.839 supervisord: enshrouded-server   1   257    0       1        1       7       0        0
2024-11-08 07:41:09.840 supervisord: enshrouded-server   2   258    0       2        2      11       0        0
2024-11-08 07:41:09.840 supervisord: enshrouded-server   3   259    0       3        3      15       0        0
2024-11-08 07:41:09.840 supervisord: enshrouded-server CPU Types:
2024-11-08 07:41:09.840 supervisord: enshrouded-server   Performance:   4   0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.840 supervisord: enshrouded-server   Efficient:     0   0000000000000000000000000000000000000000000000000000000000000000
2024-11-08 07:41:09.840 supervisord: enshrouded-server [task] TaskSystemSetup:
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]   mainWorkerCount:     2
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]   nextMainWorkerIndex: 1
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]   Group 'default'  worker:5  main:2
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]      0:  Task-default00  0000000000000000000000000000000000000000000000000000000000000000
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]      1:  Task-default01  0000000000000000000000000000000000000000000000000000000000000000
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]      2:  Task-default02  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]      3:  Task-default03  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.853 supervisord: enshrouded-server [task]      4:  Task-default04  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.856 supervisord: enshrouded-server [task]   Group 'background'  worker:3  main:0
2024-11-08 07:41:09.856 supervisord: enshrouded-server [task]      0:  Task-background00  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.856 supervisord: enshrouded-server [task]      1:  Task-background01  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.865 supervisord: enshrouded-server [task]      2:  Task-background02  0000000000000000000000000000000000000000000000000000000000001111
2024-11-08 07:41:09.866 supervisord: enshrouded-server [app] start creation step Init
2024-11-08 07:41:09.866 supervisord: enshrouded-server [app] start creation step Init_Steamworks
2024-11-08 07:41:10.938 supervisord: enshrouded-server IPC function call IClientUtils::GetSteamRealm took too long: 228 msec
2024-11-08 07:41:10.981 supervisord: enshrouded-server Setting breakpad minidump AppID = 1203620#015
2024-11-08 07:41:10.981 supervisord: enshrouded-server SteamInternal_SetMinidumpSteamID:  Caching Steam ID:  76561197960265728 [API loaded no]#015
2024-11-08 07:41:10.986 supervisord: enshrouded-server [app] start creation step Init_ResourceSystem
2024-11-08 07:41:11.013 supervisord: enshrouded-server [resource] Loaded kfc file 'Z:/opt/enshrouded/server/enshrouded_server.kfc' with 30,813 resources.
2024-11-08 07:41:12,014 INFO success: enshrouded-server entered RUNNING state, process has stayed up for > than 10 seconds (startsecs)
2024-11-08 07:41:12.033 supervisord: enshrouded-updater enshrouded-server: started
2024-11-08 07:41:12.346 supervisord: enshrouded-server [os] Started thread 0x000000000dab0008 (ResourceContent) with stack range (0x00000000192c0000-0x00000000193c0000 size:1,048,576)
2024-11-08 07:41:12.359 supervisord: enshrouded-server [os] Started thread 0x000000000dab0bd0 (AsyncIo(ResourceContent)) with stack range (0x00000000193c0000-0x00000000194c0000 size:1,048,576)
2024-11-08 07:41:12,390 INFO exited: enshrouded-updater (exit status 0; expected)
2024-11-08 07:41:12.390 supervisord: enshrouded-updater INFO - enshrouded-updater complete
2024-11-08 07:41:15.177 supervisord: enshrouded-server [resource] Loaded 189,266,568 bytes of resource data in 2.85 s
2024-11-08 07:41:15.210 supervisord: enshrouded-server [app] start creation step Init_ResourcePreload_Start
2024-11-08 07:41:15.216 supervisord: enshrouded-server [app] start creation step Init_ResourcePreload_Wait
2024-11-08 07:41:15.230 supervisord: enshrouded-server [resource] Preload of 0 bytes finished after 16.95 ms (0.00 MiB/s)
2024-11-08 07:41:15.230 supervisord: enshrouded-server [app] start creation step Init_Version
2024-11-08 07:41:15.231 supervisord: enshrouded-server Game Version (SVN): 602428
2024-11-08 07:41:15.231 supervisord: enshrouded-server [app] start creation step Init_UserSystem
2024-11-08 07:41:15.231 supervisord: enshrouded-server [user] Couldn't retrieve steam friends interface.
2024-11-08 07:41:15.232 supervisord: enshrouded-server [user] Couldn't retrieve steam user interface.
2024-11-08 07:41:15.236 supervisord: enshrouded-server [app] start creation step Init_OnlineSystem
2024-11-08 07:41:15.438 supervisord: enshrouded-server [OnlineProviderSteam] started transition from 'Uninitialized' to 'Initialized' (current='<invalid>')!
2024-11-08 07:41:15.438 supervisord: enshrouded-server [app] start creation step Init_Session
2024-11-08 07:41:15.446 supervisord: enshrouded-server [os] Started thread 0x000000000359efb0 (P2pSendThread) with stack range (0x00000000195c0000-0x00000000196c0000 size:1,048,576)
2024-11-08 07:41:15.448 supervisord: enshrouded-server [app] start creation step Init_Tracking
2024-11-08 07:41:15.472 supervisord: enshrouded-server [os] Started thread 0x000000000359ef80 (P2pReceiveThread) with stack range (0x00000000194c0000-0x00000000195c0000 size:1,048,576)
2024-11-08 07:41:15.476 supervisord: enshrouded-server [os] Started thread 0x00000000192be880 (Session) with stack range (0x00000000216c0000-0x00000000217c0000 size:1,048,576)
2024-11-08 07:41:15.480 supervisord: enshrouded-server [app] start creation step Init_SaveDataSystem
2024-11-08 07:41:15.480 supervisord: enshrouded-server [savedata] Couldn't retrieve steam remote storage interface.
2024-11-08 07:41:15.480 supervisord: enshrouded-server [savedata] Steam Cloud is disabled.
2024-11-08 07:41:15.486 supervisord: enshrouded-server [os] Started thread 0x00000000192bff90 (HttpClient) with stack range (0x00000000323d0000-0x00000000324d0000 size:1,048,576)
2024-11-08 07:41:15.495 supervisord: enshrouded-server [app] start creation step Load_ResourceObject
2024-11-08 07:41:15.495 supervisord: enshrouded-server [app] start creation step Init_TwitchDrops
2024-11-08 07:41:15.510 supervisord: enshrouded-server [os] Started thread 0x000000000a092228 (SaveData) with stack range (0x00000000324d0000-0x00000000325d0000 size:1,048,576)
2024-11-08 07:41:15.519 supervisord: enshrouded-server [app] start creation step Init_ServerThread
2024-11-08 07:41:15.523 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-08 07:41:15.524 supervisord: enshrouded-server [app] start creation step Init
2024-11-08 07:41:15.524 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-08 07:41:15.535 supervisord: enshrouded-server -------------- Session ----------------
2024-11-08 07:41:15.535 supervisord: enshrouded-server Machines:
2024-11-08 07:41:15.535 supervisord: enshrouded-server ---------------------------------------
2024-11-08 07:41:15.535 supervisord: enshrouded-server [Session] started transition from 'Lobby' to 'Host_Online' (current='<invalid>')!
2024-11-08 07:41:15.536 supervisord: enshrouded-server [Session] 'PrepareGame' (up)!
2024-11-08 07:41:15.548 supervisord: enshrouded-server [os] Started thread 0x000000000a09f148 (HttpClient) with stack range (0x00000000325d0000-0x00000000326d0000 size:1,048,576)
2024-11-08 07:41:15.548 supervisord: enshrouded-server [os] Started thread 0x000000000a09fd40 (GameServer) with stack range (0x00000000326d0000-0x00000000327d0000 size:1,048,576)

Good startup

INFO - Creating server folders (save, logs, backup)
INFO - Setting uid:gid of enshrouded to 4711:4711
usermod: no changes
INFO - Setting up syslogd - logging to stdout
2024-11-07 15:06:13,077 INFO Included extra file "/usr/local/etc/supervisor/conf.d/syslog.conf" during parsing
2024-11-07 15:06:13,077 INFO Set uid to user 0 succeeded
2024-11-07 15:06:13,082 INFO RPC interface 'supervisor' initialized
2024-11-07 15:06:13,083 INFO supervisord started with pid 1
2024-11-07 15:06:14,085 INFO spawned: 'rsyslogd' with pid 16
2024-11-07 15:06:14,088 INFO spawned: 'crond' with pid 17
2024-11-07 15:06:14,090 INFO spawned: 'enshrouded-bootstrap' with pid 18
2024-11-07 15:06:14.103 rsyslogd: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.2312.0 try https://www.rsyslog.com/e/2307 ]
2024-11-07 15:06:14.103 rsyslogd: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="16" x-info="https://www.rsyslog.com"] start
2024-11-07 15:06:14,103 INFO success: enshrouded-bootstrap entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2024-11-07 15:06:14.108 supervisord: enshrouded-bootstrap INFO - Running enshrouded-bootstrap
2024-11-07 15:06:14.715 supervisord: enshrouded-bootstrap Defaulting to user installation because normal site-packages is not writeable
2024-11-07 15:06:14.977 supervisord: enshrouded-bootstrap Collecting python-a2s==1.3.0
2024-11-07 15:06:15.039 supervisord: enshrouded-bootstrap   Downloading python_a2s-1.3.0-py3-none-any.whl.metadata (4.7 kB)
2024-11-07 15:06:15.058 supervisord: enshrouded-bootstrap Downloading python_a2s-1.3.0-py3-none-any.whl (15 kB)
2024-11-07 15:06:15,121 INFO success: rsyslogd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2024-11-07 15:06:15,121 INFO success: crond entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2024-11-07 15:06:15.121 supervisord: enshrouded-bootstrap Installing collected packages: python-a2s
2024-11-07 15:06:15.163 supervisord: enshrouded-bootstrap Successfully installed python-a2s-1.3.0
2024-11-07 15:06:15,460 INFO spawned: 'enshrouded-updater' with pid 161
2024-11-07 15:06:15,460 INFO success: enshrouded-updater entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2024-11-07 15:06:15.461 supervisord: enshrouded-bootstrap enshrouded-updater: started
2024-11-07 15:06:15.476 supervisord: enshrouded-updater INFO - Running enshrouded-updater
2024-11-07 15:06:15,492 INFO exited: enshrouded-bootstrap (exit status 0; expected)
2024-11-07 15:06:15.492 supervisord: enshrouded-bootstrap INFO - Bootstrap complete
2024-11-07 15:06:15.592 supervisord: enshrouded-updater INFO - Enshrouded server needs to be updated
2024-11-07 15:06:23.507 supervisord: enshrouded-updater Redirecting stderr to '/home/enshrouded/Steam/logs/stderr.txt'
2024-11-07 15:06:23.507 supervisord: enshrouded-updater ILocalize::AddFile() failed to load file "public/steambootstrapper_english.txt".
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [  0%] Checking for available update...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Downloading update (0 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [  0%] Downloading update (0 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [  0%] Downloading update (0 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [  0%] Downloading update (3,835 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [  7%] Downloading update (9,110 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 18%] Downloading update (12,345 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 25%] Downloading update (15,832 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 32%] Downloading update (19,255 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 39%] Downloading update (22,732 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 47%] Downloading update (26,461 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 54%] Downloading update (29,937 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 62%] Downloading update (32,992 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 68%] Downloading update (36,047 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 74%] Downloading update (40,452 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 83%] Downloading update (42,106 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 87%] Downloading update (43,813 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 90%] Downloading update (45,951 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [ 95%] Downloading update (48,184 of 48,184 KB)...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [100%] Download Complete.
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Applying update...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Extracting package...
2024-11-07 15:06:23.507 supervisord: message repeated 3 times: [ enshrouded-updater [----] Extracting package...]
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Installing update...
2024-11-07 15:06:23.507 supervisord: message repeated 8 times: [ enshrouded-updater [----] Installing update...]
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Cleaning up...
2024-11-07 15:06:23.507 supervisord: enshrouded-updater [----] Update complete, launching...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater Redirecting stderr to '/home/enshrouded/Steam/logs/stderr.txt'
2024-11-07 15:06:27.499 supervisord: enshrouded-updater Logging directory: '/home/enshrouded/Steam/logs'
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [  0%] Checking for available updates...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Verifying installation...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [  0%] Downloading update...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [  0%] Checking for available updates...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Download complete.
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Extracting package...
2024-11-07 15:06:27.499 supervisord: message repeated 3 times: [ enshrouded-updater [----] Extracting package...]
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Installing update...
2024-11-07 15:06:27.499 supervisord: message repeated 8 times: [ enshrouded-updater [----] Installing update...]
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Cleaning up...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater [----] Update complete, launching Steamcmd...
2024-11-07 15:06:27.499 supervisord: enshrouded-updater UpdateUI: skip show logo
2024-11-07 15:06:27.501 supervisord: enshrouded-updater steamcmd.sh[182]: Restarting steamcmd by request...
2024-11-07 15:06:28.241 supervisord: enshrouded-updater Redirecting stderr to '/home/enshrouded/Steam/logs/stderr.txt'
2024-11-07 15:06:28.241 supervisord: enshrouded-updater Logging directory: '/home/enshrouded/Steam/logs'
2024-11-07 15:06:28.241 supervisord: enshrouded-updater [  0%] Checking for available updates...
2024-11-07 15:06:28.241 supervisord: enshrouded-updater [----] Verifying installation...
2024-11-07 15:06:28.241 supervisord: enshrouded-updater UpdateUI: skip show logoSteam Console Client (c) Valve Corporation - version 1730854361
2024-11-07 15:06:28.241 supervisord: enshrouded-updater -- type 'quit' to exit --
2024-11-07 15:06:28.241 supervisord: enshrouded-updater Loading Steam API...
2024-11-07 15:06:28.444 supervisord: enshrouded-updater IPC function call IClientUtils::GetConnectedUniverse took too long: 51 msec
2024-11-07 15:06:28.444 supervisord: enshrouded-updater IPC function call IClientUtils::GetIPCountry took too long: 50 msec
2024-11-07 15:06:28.444 supervisord: enshrouded-updater IPC function call IClientUtils::GetServerRealTime took too long: 48 msec
2024-11-07 15:06:28.444 supervisord: enshrouded-updater OK
2024-11-07 15:06:28.444 supervisord: enshrouded-updater "@sSteamCmdForcePlatformType" = "windows"
2024-11-07 15:06:28.444 supervisord: enshrouded-updater #033[0m
2024-11-07 15:06:28.452 supervisord: enshrouded-updater 
2024-11-07 15:06:28.452 supervisord: enshrouded-updater Connecting anonymously to Steam Public...
2024-11-07 15:06:31.624 supervisord: enshrouded-updater OK
2024-11-07 15:06:31.624 supervisord: enshrouded-updater Waiting for client config...OK
2024-11-07 15:06:31.624 supervisord: enshrouded-updater Waiting for user info...
2024-11-07 15:06:40.827 supervisord: enshrouded-updater OK
2024-11-07 15:06:40.827 supervisord: enshrouded-updater  Update state (0x3) reconfiguring, progress: 0.00 (0 / 0)
2024-11-07 15:06:40.827 supervisord: enshrouded-updater  Update state (0x3) reconfiguring, progress: 0.00 (0 / 0)
2024-11-07 15:06:40.827 supervisord: enshrouded-updater  Update state (0x61) downloading, progress: 64.88 (136206088 / 209923048)
2024-11-07 15:06:40.827 supervisord: enshrouded-updater IPC function call IClientAppManager::GetUpdateInfo took too long: 51 msec
2024-11-07 15:06:40.827 supervisord: enshrouded-updater Success! App '2278520' fully installed.
2024-11-07 15:06:41,142 INFO spawned: 'enshrouded-server' with pid 245
2024-11-07 15:06:41.155 supervisord: enshrouded-server INFO - Running enshrouded-server
2024-11-07 15:06:41.271 supervisord: enshrouded-server fsync: up and running.
2024-11-07 15:06:42.029 supervisord: enshrouded-server 0070:err:wineusb:DriverEntry Failed to initialize Unix library, status 0xc0000135.
2024-11-07 15:06:42.029 supervisord: enshrouded-server 0070:err:ntoskrnl:ZwLoadDriver failed to create driver L"\\Registry\\Machine\\System\\CurrentControlSet\\Services\\wineusb": c0000135
2024-11-07 15:06:43,047 INFO reaped unknown pid 269 (exit status 0)
2024-11-07 15:06:50,065 INFO reaped unknown pid 254 (exit status 0)
2024-11-07 15:06:52,072 INFO success: enshrouded-server entered RUNNING state, process has stayed up for > than 10 seconds (startsecs)
2024-11-07 15:06:52.099 supervisord: enshrouded-updater enshrouded-server: started
2024-11-07 15:06:52.355 supervisord: enshrouded-updater INFO - Releasing PID file /var/run/enshrouded/enshrouded-updater.pid
2024-11-07 15:06:52,586 INFO exited: enshrouded-updater (exit status 0; expected)
2024-11-07 15:06:52.419 supervisord: enshrouded-updater INFO - enshrouded-updater complete
2024-11-07 15:06:53.795 supervisord: enshrouded-server 00ec:err:kerberos:kerberos_LsaApInitializePackage no Kerberos support, expect problems
2024-11-07 15:06:58.089 supervisord: enshrouded-server GetTimerResolution 0: 1,000 ( 1,000 - 15,625 ) us
2024-11-07 15:06:58.089 supervisord: enshrouded-server SetTimerResolution 0: 1,000 us
2024-11-07 15:06:58.089 supervisord: enshrouded-server GetTimerResolution 0: 1,000 ( 1,000 - 15,625 ) us
2024-11-07 15:06:58.730 supervisord: enshrouded-server [os] Started thread 0x00000000021d6a68 (MessageSystem) with stack range (0x000000000c040000-0x000000000c140000 size:1,048,576)
2024-11-07 15:06:58.747 supervisord: enshrouded-server [os] Started thread 0x000000000236a950 (Task-default03) with stack range (0x000000000c540000-0x000000000c940000 size:4,194,304)
2024-11-07 15:06:58.755 supervisord: enshrouded-server [os] Started thread 0x000000000226a7e8 (Task-default04) with stack range (0x000000000c940000-0x000000000cd40000 size:4,194,304)
2024-11-07 15:06:58.756 supervisord: enshrouded-server [os] Started thread 0x000000000286b810 (Task-background00) with stack range (0x000000000cd40000-0x000000000d140000 size:4,194,304)
2024-11-07 15:06:58.769 supervisord: enshrouded-server [os] Started thread 0x000000000246aa90 (Task-default02) with stack range (0x000000000c140000-0x000000000c540000 size:4,194,304)
2024-11-07 15:06:58.769 supervisord: enshrouded-server [os] Started thread 0x00000000021d6938 (NetworkSystem) with stack range (0x0000000001c40000-0x0000000001d40000 size:1,048,576)
2024-11-07 15:06:58.782 supervisord: enshrouded-server [os] Started thread 0x000000000286b948 (Task-background01) with stack range (0x000000000d140000-0x000000000d540000 size:4,194,304)
2024-11-07 15:06:58.799 supervisord: enshrouded-server [os] Started thread 0x0000000002a6bcd0 (Task-background02) with stack range (0x000000000d540000-0x000000000d940000 size:4,194,304)
2024-11-07 15:06:58.836 supervisord: enshrouded-server [os] Started thread 0x0000000002a6dd08 (BackgroundTask) with stack range (0x000000000d950000-0x000000000da50000 size:1,048,576)
2024-11-07 15:06:58.889 supervisord: enshrouded-server CpuInfo:
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Type:      Intel
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Vendor:    'GenuineIntel'
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Brand:     'Intel(R) Xeon(R) Gold 6240 CPU @ 2.60GHz'
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Cpus:      4
2024-11-07 15:06:58.889 supervisord: enshrouded-server         Perf:  4 1111
2024-11-07 15:06:58.889 supervisord: enshrouded-server         Effi:  0 0
2024-11-07 15:06:58.889 supervisord: enshrouded-server     CacheLine: 64
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Simd:      SSE2,SSE3,SSSE3,SSE41,SSE42,AVX,AVX2
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Other:     FMA,BMI1,BMI2,F16C,CTSC,AES,RDRAND
2024-11-07 15:06:58.889 supervisord: enshrouded-server MemoryInfo:
2024-11-07 15:06:58.889 supervisord: enshrouded-server     PhysTotal:   16,771,219,456
2024-11-07 15:06:58.889 supervisord: enshrouded-server     PhysAvail:   15,404,056,576
2024-11-07 15:06:58.889 supervisord: enshrouded-server     SwapTotal:   25,361,154,048
2024-11-07 15:06:58.889 supervisord: enshrouded-server     SwapAvail:   23,993,450,496
2024-11-07 15:06:58.889 supervisord: enshrouded-server OsSystemInfo:
2024-11-07 15:06:58.889 supervisord: enshrouded-server     ProductName:    'Windows 10 Pro'
2024-11-07 15:06:58.889 supervisord: enshrouded-server     DisplayVersion: '21H1'
2024-11-07 15:06:58.889 supervisord: enshrouded-server     Version:        10.0 (19043)
2024-11-07 15:06:58.906 supervisord: enshrouded-server 'gameSettings' will not be applied Preset is not set to 'Custom' 
2024-11-07 15:06:58.981 supervisord: enshrouded-server [holistic] Backup log to '/opt/enshrouded/server/logs/backup/enshrouded_server_2024-11-07T15-06-58.log'.
2024-11-07 15:06:58.989 supervisord: enshrouded-server [enshrouded] Create logfile
2024-11-07 15:06:58.995 supervisord: enshrouded-server enshrouded_server(detached HEAD) - version a19b06956a82d073048ab0121d6ced02ecc5d3b1 (master)
2024-11-07 15:06:59.010 supervisord: enshrouded-server CPUs:
2024-11-07 15:06:59.019 supervisord: enshrouded-server  Idx   Id  Group  LogIdx  CoreIdx  LLCIdx  NumaIdx  EffClass
2024-11-07 15:06:59.025 supervisord: enshrouded-server   0   256    0       0        0       3       0        0
2024-11-07 15:06:59.032 supervisord: enshrouded-server   1   257    0       1        1       7       0        0
2024-11-07 15:06:59.039 supervisord: enshrouded-server   2   258    0       2        2      11       0        0
2024-11-07 15:06:59.045 supervisord: enshrouded-server   3   259    0       3        3      15       0        0
2024-11-07 15:06:59.052 supervisord: enshrouded-server CPU Types:
2024-11-07 15:06:59.059 supervisord: enshrouded-server   Performance:   4   0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.065 supervisord: enshrouded-server   Efficient:     0   0000000000000000000000000000000000000000000000000000000000000000
2024-11-07 15:06:59.072 supervisord: enshrouded-server [task] TaskSystemSetup:
2024-11-07 15:06:59.079 supervisord: enshrouded-server [task]   mainWorkerCount:     2
2024-11-07 15:06:59.085 supervisord: enshrouded-server [task]   nextMainWorkerIndex: 1
2024-11-07 15:06:59.085 supervisord: enshrouded-server [task]   Group 'default'  worker:5  main:2
2024-11-07 15:06:59.092 supervisord: enshrouded-server [task]      0:  Task-default00  0000000000000000000000000000000000000000000000000000000000000000
2024-11-07 15:06:59.092 supervisord: enshrouded-server [task]      1:  Task-default01  0000000000000000000000000000000000000000000000000000000000000000
2024-11-07 15:06:59.102 supervisord: enshrouded-server [task]      2:  Task-default02  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.109 supervisord: enshrouded-server [task]      3:  Task-default03  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.115 supervisord: enshrouded-server [task]      4:  Task-default04  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.122 supervisord: enshrouded-server [task]   Group 'background'  worker:3  main:0
2024-11-07 15:06:59.128 supervisord: enshrouded-server [task]      0:  Task-background00  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.128 supervisord: enshrouded-server [task]      1:  Task-background01  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.128 supervisord: enshrouded-server [task]      2:  Task-background02  0000000000000000000000000000000000000000000000000000000000001111
2024-11-07 15:06:59.132 supervisord: enshrouded-server [app] start creation step Init
2024-11-07 15:06:59.142 supervisord: enshrouded-server [app] start creation step Init_Steamworks
2024-11-07 15:07:00.935 supervisord: enshrouded-server IPC function call IClientUtils::GetSteamRealm took too long: 531 msec
2024-11-07 15:07:00.985 supervisord: enshrouded-server IPC function call IClientUtils::GetConnectedUniverse took too long: 52 msec
2024-11-07 15:07:01.089 supervisord: enshrouded-server Setting breakpad minidump AppID = 1203620#015
2024-11-07 15:07:01.099 supervisord: enshrouded-server SteamInternal_SetMinidumpSteamID:  Caching Steam ID:  76561197960265728 [API loaded no]#015
2024-11-07 15:07:01.152 supervisord: enshrouded-server [app] start creation step Init_ResourceSystem
2024-11-07 15:07:01.154 supervisord: enshrouded-server [resource] Loaded kfc file 'Z:/opt/enshrouded/server/enshrouded_server.kfc' with 30,813 resources.
2024-11-07 15:07:02.806 supervisord: enshrouded-server [os] Started thread 0x000000000da50008 (ResourceContent) with stack range (0x0000000019260000-0x0000000019360000 size:1,048,576)
2024-11-07 15:07:02.815 supervisord: enshrouded-server [os] Started thread 0x000000000da50bd0 (AsyncIo(ResourceContent)) with stack range (0x0000000019360000-0x0000000019460000 size:1,048,576)
2024-11-07 15:07:05.368 supervisord: enshrouded-server [resource] Loaded 189,266,568 bytes of resource data in 2.58 s
2024-11-07 15:07:05.389 supervisord: enshrouded-server [app] start creation step Init_ResourcePreload_Start
2024-11-07 15:07:05.392 supervisord: enshrouded-server [app] start creation step Init_ResourcePreload_Wait
2024-11-07 15:07:05.412 supervisord: enshrouded-server [resource] Preload of 0 bytes finished after 19.07 ms (0.00 MiB/s)
2024-11-07 15:07:05.412 supervisord: enshrouded-server [app] start creation step Init_Version
2024-11-07 15:07:05.412 supervisord: enshrouded-server Game Version (SVN): 602428
2024-11-07 15:07:05.412 supervisord: enshrouded-server [app] start creation step Init_UserSystem
2024-11-07 15:07:05.412 supervisord: enshrouded-server [user] Couldn't retrieve steam friends interface.
2024-11-07 15:07:05.412 supervisord: enshrouded-server [user] Couldn't retrieve steam user interface.
2024-11-07 15:07:05.412 supervisord: enshrouded-server [app] start creation step Init_OnlineSystem
2024-11-07 15:07:05.452 supervisord: enshrouded-server [OnlineProviderSteam] started transition from 'Uninitialized' to 'Initialized' (current='<invalid>')!
2024-11-07 15:07:05.452 supervisord: enshrouded-server [app] start creation step Init_Session
2024-11-07 15:07:05.459 supervisord: enshrouded-server [app] start creation step Init_Tracking
2024-11-07 15:07:05.462 supervisord: enshrouded-server [os] Started thread 0x000000000353ef80 (P2pReceiveThread) with stack range (0x0000000019460000-0x0000000019560000 size:1,048,576)
2024-11-07 15:07:05.462 supervisord: enshrouded-server [app] start creation step Init_SaveDataSystem
2024-11-07 15:07:05.462 supervisord: enshrouded-server [savedata] Couldn't retrieve steam remote storage interface.
2024-11-07 15:07:05.466 supervisord: enshrouded-server [savedata] Steam Cloud is disabled.
2024-11-07 15:07:05.467 supervisord: enshrouded-server [app] start creation step Load_ResourceObject
2024-11-07 15:07:05.490 supervisord: enshrouded-server [os] Started thread 0x000000000353efb0 (P2pSendThread) with stack range (0x0000000019560000-0x0000000019660000 size:1,048,576)
2024-11-07 15:07:05.495 supervisord: enshrouded-server [app] start creation step Init_TwitchDrops
2024-11-07 15:07:05.495 supervisord: enshrouded-server [app] start creation step Init_ServerThread
2024-11-07 15:07:05.496 supervisord: enshrouded-server [os] Started thread 0x000000001925ff90 (HttpClient) with stack range (0x0000000032370000-0x0000000032470000 size:1,048,576)
2024-11-07 15:07:05.499 supervisord: enshrouded-server [os] Started thread 0x000000001925e880 (Session) with stack range (0x0000000021660000-0x0000000021760000 size:1,048,576)
2024-11-07 15:07:05.499 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-07 15:07:05.515 supervisord: enshrouded-server [os] Started thread 0x000000000a032228 (SaveData) with stack range (0x0000000032470000-0x0000000032570000 size:1,048,576)
2024-11-07 15:07:05.529 supervisord: enshrouded-server [os] Started thread 0x000000000a03fd40 (GameServer) with stack range (0x0000000032670000-0x0000000032770000 size:1,048,576)
2024-11-07 15:07:05.529 supervisord: enshrouded-server [os] Started thread 0x000000000a03f148 (HttpClient) with stack range (0x0000000032570000-0x0000000032670000 size:1,048,576)
2024-11-07 15:07:05.565 supervisord: enshrouded-server [app] start creation step Init
2024-11-07 15:07:05.565 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-07 15:07:05.582 supervisord: enshrouded-server [Session] started transition from 'Lobby' to 'Host_Online' (current='<invalid>')!
2024-11-07 15:07:05.589 supervisord: enshrouded-server [Session] 'PrepareGame' (up)!
2024-11-07 15:07:05.616 supervisord: enshrouded-server -------------- Session ----------------
2024-11-07 15:07:05.616 supervisord: enshrouded-server Machines:
2024-11-07 15:07:05.616 supervisord: enshrouded-server   m#0(128): up 0 (0), down 0 (0), remote 0 (0), limit 2,048, lost 0, ping 9,223,372,036,854 ms, EstablishingBaseline
2024-11-07 15:07:05.616 supervisord: enshrouded-server ---------------------------------------
2024-11-07 15:07:09.599 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 178 msec
2024-11-07 15:07:10.499 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 73 msec
2024-11-07 15:07:13.572 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 150 msec
2024-11-07 15:07:15.659 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 237 msec
2024-11-07 15:07:16.555 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 133 msec
2024-11-07 15:07:18.715 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 263 msec
2024-11-07 16:00:03,833 INFO spawned: 'enshrouded-updater' with pid 751
2024-11-07 16:00:03,853 INFO success: enshrouded-updater entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2024-11-07 16:00:04.216 supervisord: enshrouded-updater INFO - Running enshrouded-updater
2024-11-07 16:00:04.808 supervisord: enshrouded-updater INFO - Enshrouded server is already the latest version
2024-11-07 16:00:07,672 INFO exited: enshrouded-updater (exit status 0; expected)
2024-11-07 16:00:07.672 supervisord: enshrouded-updater INFO - enshrouded-updater complete
2024-11-07 16:00:26.608 supervisord: enshrouded-server IPC function call IClientNetworking::IsP2PPacketAvailable took too long: 43 msec
@red15 red15 added the bug 🐞 Something isn't working label Nov 8, 2024
@cp-fabian-pittroff
Copy link
Member

Hey @red15,
there is also a wine version available to download directly (tags: stable-wine or <version>-wine). Unfortunately the wine version does need more compute power. There are also dev images with wine in the staging version, so you could test if there are some performance improvements in the newer versions.

So now to the problem with the proton image itself. Can you test if you can read the steam query output and get any information back with the proton version?

exec inside of enshrouded container:

su - enshrouded # when connected as root
python3 -c 'import a2s; print(a2s.info(("127.0.0.1",15637)));'

You should get some information about the server - like name, version etc.
I'm honestly not sure, why it should not work with the proton version. The startup seems to look good, you get the two logs

[Session] started transition from 'Lobby' to 'Host_Online' (current='<invalid>')!
[Session] 'PrepareGame' (up)!

which indicate the server is up and running.

@red15
Copy link
Author

red15 commented Nov 8, 2024

Hey @red15, there is also a wine version available to download directly (tags: stable-wine or <version>-wine). Unfortunately the wine version does need more compute power. There are also dev images with wine in the staging version, so you could test if there are some performance improvements in the newer versions.

Ah good to know I've just been pulling latest will give those a try. Regarding CPU usage I found actually the proton was hogging 4 cores at 50-80% (while not actively accepting connections) and wine is only pulling around 30-50% and working :)

So now to the problem with the proton image itself. Can you test if you can read the steam query output and get any information back with the proton version?

exec inside of enshrouded container:

su - enshrouded # when connected as root
python3 -c 'import a2s; print(a2s.info(("127.0.0.1",15637)));'

You should get some information about the server - like name, version etc.

I've been using the Steam->View->Game Servers tab from my client to verify the responses and switching from proton to wine actually started showing content. So I can confirm it's not something on the network setup (which I'll admit is not very standard)

I'm honestly not sure, why it should not work with the proton version. The startup seems to look good, you get the two logs

[Session] started transition from 'Lobby' to 'Host_Online' (current='<invalid>')!
[Session] 'PrepareGame' (up)!

which indicate the server is up and running.

I've just tested dev-proton tag and seem to end up also with an "empty" Session table at the "end" of the startup.
Testing stable-wine indeed again produces the desired session table containing the current host.

@cp-fabian-pittroff
Copy link
Member

I updated the proton-ge version to 9-18 and is available with dev-proton. Could you try that image again?
But good to hear that wine is working for you and also don't need as much resources.

In the log run I hope we get a native linux server, so I can get rid of wine or proton.

@red15
Copy link
Author

red15 commented Nov 8, 2024

Looks like it did something, startup log now ends with :

2024-11-08 23:05:39.452 supervisord: enshrouded-server [app] start creation step Init_SaveDataSystem
2024-11-08 23:05:39.452 supervisord: enshrouded-server [savedata] Couldn't retrieve steam remote storage interface.
2024-11-08 23:05:39.452 supervisord: enshrouded-server [savedata] Steam Cloud is disabled.
2024-11-08 23:05:39.453 supervisord: enshrouded-server [app] start creation step Load_ResourceObject
2024-11-08 23:05:39.471 supervisord: enshrouded-server [app] start creation step Init_TwitchDrops
2024-11-08 23:05:39.489 supervisord: enshrouded-server [app] start creation step Init_ServerThread
2024-11-08 23:05:39.489 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-08 23:05:39.489 supervisord: enshrouded-server [app] start creation step Init
2024-11-08 23:05:39.495 supervisord: enshrouded-server [app] start creation step StartGame
2024-11-08 23:05:39.495 supervisord: enshrouded-server [os] Started thread 0x000000000a13f148 (HttpClient) with stack range (0x0000000032670000-0x0000000032770000 size:1,048,576)
2024-11-08 23:05:39.504 supervisord: enshrouded-server [os] Started thread 0x000000001935ff90 (HttpClient) with stack range (0x0000000032470000-0x0000000032570000 size:1,048,576)
2024-11-08 23:05:39.504 supervisord: enshrouded-server [os] Started thread 0x000000000a132228 (SaveData) with stack range (0x0000000032570000-0x0000000032670000 size:1,048,576)
2024-11-08 23:05:39.514 supervisord: enshrouded-server [os] Started thread 0x000000000a13fd40 (GameServer) with stack range (0x0000000032770000-0x0000000032870000 size:1,048,576)
2024-11-08 23:05:39.515 supervisord: enshrouded-server [Session] started transition from 'Lobby' to 'Host_Online' (current='<invalid>')!
2024-11-08 23:05:39.515 supervisord: enshrouded-server [Session] 'PrepareGame' (up)!
2024-11-08 23:05:39.541 supervisord: enshrouded-server -------------- Session ----------------
2024-11-08 23:05:39.541 supervisord: enshrouded-server Machines:
2024-11-08 23:05:39.541 supervisord: enshrouded-server   m#0(128): up 0 (0), down 0 (0), remote 0 (0), limit 2,048, lost 0, ping 9,223,372,036,854 ms, EstablishingBaseline
2024-11-08 23:05:39.541 supervisord: enshrouded-server ---------------------------------------

But alas the ServerQuery is still not returning anything:

╰─○ podman exec -it enshrouded-proton /bin/bash
root@enshrouded:/usr/local/etc/enshrouded# su - enshrouded
$ python3 -c 'import a2s; print(a2s.info(("127.0.0.1", 15637)));'
Traceback (most recent call last):
  File "<string>", line 1, in <module>
  File "/home/enshrouded/.local/lib/python3.12/site-packages/a2s/info.py", line 182, in info
    return request_sync(address, timeout, encoding, InfoProtocol)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/enshrouded/.local/lib/python3.12/site-packages/a2s/a2s_sync.py", line 22, in request_sync
    response = request_sync_impl(conn, encoding, a2s_proto)
               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/enshrouded/.local/lib/python3.12/site-packages/a2s/a2s_sync.py", line 28, in request_sync_impl
    resp_data = conn.request(a2s_proto.serialize_request(challenge))
                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/enshrouded/.local/lib/python3.12/site-packages/a2s/a2s_sync.py", line 92, in request
    return self.recv()
           ^^^^^^^^^^^
  File "/home/enshrouded/.local/lib/python3.12/site-packages/a2s/a2s_sync.py", line 67, in recv
    packet = self._socket.recv(65535)
             ^^^^^^^^^^^^^^^^^^^^^^^^
TimeoutError: timed out

Would it be worth implementing this check as a HEALTHCHECK btw?
Given some retries and timeout values it could serve the purpose well?

Might want to ensure it's not really using localhost as that would not always work, think it's best to have the Container's hostname in there (should always be pointing to 127.0.0.1 in /etc/hosts anyway or proper ip in case of more complex network setups)

@cp-fabian-pittroff
Copy link
Member

well thats a bummer and I'm not sure why and what is causing that issue. There seems to be no clear problem on startup, but maybe hangs when initializing the steam connection. Typically thats the next thing that gets logged at that point.

Unfortunately the healthcheck is not that strait forward. I use supervisor - thats the pid 1 - and it manages all subprocesses. Autoupdates, backups etc.
In case of an update, the server is not responding, but thats on purpose. So I could only really implement it for supervisor and come up with a own healthcheck mechanism within supervisor.

I need to think about that.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug 🐞 Something isn't working
Projects
None yet
Development

No branches or pull requests

2 participants