lloesche / valheim-server-docker

Valheim dedicated gameserver with automatic update, World backup, BepInEx and ValheimPlus mod support
https://hub.docker.com/r/lloesche/valheim-server
Apache License 2.0
1.96k stars 276 forks source link

Unable to restore server from backup #427

Open kamilgregorczyk opened 2 years ago

kamilgregorczyk commented 2 years ago

https://github.com/lloesche/valheim-server-docker/discussions/414

I've been trying to restore server from backup. I delete all /worlds files and place those from backup (.db and .fwl) and the world gets overriden with empty one. My files from backup get renamed to .db.old and .fwl.old and new world is generated.

I also tried to use my steam's save as a server, same issue, I couldn't find the reason why it's happening in logs

After putting old world from steam:

root@valheim-server-755b7779b5-mtr8l:/config/worlds# ls -lah
total 15M
drwxr-xr-x 2 root root 4.0K Dec 14 19:59 .
drwxr-xr-x 5 root root 4.0K Dec 13 22:39 ..
-rw-r--r-- 1 root root  15M Dec 14 19:48 ZadupieNowe3.db
-rw-r--r-- 1 root root   48 Dec 14 19:48 ZadupieNowe3.fwl

and then after reboot of the pod

root@valheim-server-777fbdff84-8m6nm:/config/worlds# ls -lah
total 15M
drwxr-xr-x 2 root root 4.0K Dec 14 20:58 .
drwxr-xr-x 5 root root 4.0K Dec 14 20:58 ..
-rw-r--r-- 1 root root 190K Dec 14 20:58 ZadupieNowe3.db
-rw-r--r-- 1 root root  15M Dec 14 20:58 ZadupieNowe3.db.old
-rw-r--r-- 1 root root   48 Dec 14 20:58 ZadupieNowe3.fwl
-rw-r--r-- 1 root root   48 Dec 14 20:58 ZadupieNowe3.fwl.old
valheim-server
INFO - Setting uid:gid of valheim to 0:0
valheim-server
INFO - Setting timezone Etc/UTC
valheim-server
INFO - Setting up syslogd - logging to stdout
valheim-server
2021-12-14 20:58:48,422 INFO Included extra file "/usr/local/etc/supervisor/conf.d/syslog.conf" during parsing
valheim-server
2021-12-14 20:58:48,422 INFO Set uid to user 0 succeeded
valheim-server
2021-12-14 20:58:48,435 INFO RPC interface 'supervisor' initialized
valheim-server
2021-12-14 20:58:48,436 INFO supervisord started with pid 1
valheim-server
2021-12-14 20:58:49,439 INFO spawned: 'syslogd' with pid 26
valheim-server
2021-12-14 20:58:49,442 INFO spawned: 'crond' with pid 27
valheim-server
2021-12-14 20:58:49,446 INFO spawned: 'valheim-bootstrap' with pid 28
valheim-server
Dec 14 20:58:49 syslogd started: BusyBox v1.34.1
valheim-server
2021-12-14 20:58:49,451 INFO success: valheim-bootstrap entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
valheim-server
Dec 14 20:58:49 cron[27]: (CRON) INFO (pidfile fd = 3)
valheim-server
Dec 14 20:58:49 cron[27]: (CRON) INFO (Running @reboot jobs)
valheim-server
Dec 14 20:58:49 /supervisord: valheim-bootstrap DEBUG - [28] - Running commit 565942d07e71fb075d481ab7e64085a989bdd305
valheim-server
Dec 14 20:58:49 /supervisord: valheim-bootstrap DEBUG - [28] - Creating cron to do world backups using schedule 0 * * * *
valheim-server
Dec 14 20:58:49 /supervisord: valheim-bootstrap DEBUG - [28] - Creating cron to check for updates using schedule */15 * * * *
valheim-server
Dec 14 20:58:49 /supervisord: valheim-bootstrap DEBUG - [28] - Creating cron to restart valheim-server using schedule 0 5 * * *
valheim-server
Dec 14 20:58:49 crontab[35]: (root) REPLACE (root)
valheim-server
2021-12-14 20:58:49,953 INFO spawned: 'valheim-updater' with pid 38
valheim-server
Dec 14 20:58:49 /supervisord: valheim-updater DEBUG - [38] - Running Valheim Server updater as user valheim uid 0
valheim-server
Dec 14 20:58:49 /supervisord: valheim-updater DEBUG - [38] - Kernel: Linux valheim-server-777fbdff84-8m6nm 5.4.0-91-generic #102-Ubuntu SMP Fri Nov 5 16:31:28 UTC 2021 x86_64 GNU/Linux
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater DEBUG - [38] - Found CPU with 800.005 MHz
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater DEBUG - [38] - Memory total/free/available: 16259204/6438372/14029264
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater DEBUG - [38] - Storage configuration:
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater Filesystem Size Used Avail Use% Mounted on
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater overlay 467G 36G 411G 8% /
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater /dev/longhorn/pvc-30e49edd-9c3d-41f4-8093-29c36a536359 3.9G 45M 3.9G 2% /config
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater /dev/longhorn/pvc-adb16d3d-23d0-4ac9-b8f2-d6f012e1157c 4.9G 2.1G 2.8G 43% /opt/valheim
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater grep: /etc/mtab: No such file or directory
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater ERROR - Error in line 28 command 'grep -v -E "(/sys/|/etc/|/run/)"' exited with code 1 in ::main::main called in line 302
valheim-server
2021-12-14 20:58:50,456 INFO success: syslogd entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
valheim-server
2021-12-14 20:58:50,457 INFO success: crond entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater DEBUG - [38] - Valheim updater was just started - skipping connected players check
valheim-server
Dec 14 20:58:50 /supervisord: valheim-updater INFO - Downloading/updating/validating Valheim server from Steam
valheim-server
2021-12-14 20:58:51,520 INFO success: valheim-updater entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
valheim-server
Dec 14 20:58:51 /supervisord: valheim-bootstrap valheim-updater: started
valheim-server
2021-12-14 20:58:51,993 INFO spawned: 'valheim-backup' with pid 73
valheim-server
Dec 14 20:58:52 /supervisord: valheim-backup INFO - Backing up Valheim server worlds to /config/backups/worlds-20211214-205852.zip
valheim-server
Dec 14 20:58:52 /supervisord: valheim-backup adding: worlds/ (stored 0%)
valheim-server
Dec 14 20:58:52 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.db
valheim-server
Dec 14 20:58:52 /supervisord: valheim-backup (deflated 51%)
valheim-server
Dec 14 20:58:52 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.db.old
valheim-server
2021-12-14 20:58:53,074 INFO success: valheim-backup entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
valheim-server
Dec 14 20:58:53 /supervisord: valheim-bootstrap valheim-backup: started
valheim-server
2021-12-14 20:58:53,112 INFO exited: valheim-bootstrap (exit status 0; expected)
valheim-server
Dec 14 20:58:54 /supervisord: valheim-backup (deflated 68%)
valheim-server
Dec 14 20:58:54 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.fwl.old
valheim-server
Dec 14 20:58:54 /supervisord: valheim-backup (deflated 2%)
valheim-server
Dec 14 20:58:54 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.fwl (deflated 4%)
valheim-server
Dec 14 20:58:54 /supervisord: valheim-backup INFO - Removing backups older than 3 days
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater Redirecting stderr to '/home/valheim/Steam/logs/stderr.txt'
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 0%] Checking for available updates...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Downloading update (48 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 0%] Downloading update (2,696 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 5%] Downloading update (5,389 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 10%] Downloading update (7,871 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 14%] Downloading update (9,751 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 18%] Downloading update (11,454 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 21%] Downloading update (13,268 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 24%] Downloading update (15,171 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 28%] Downloading update (17,040 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 31%] Downloading update (18,968 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 35%] Downloading update (20,665 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 38%] Downloading update (22,543 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 41%] Downloading update (24,295 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 45%] Downloading update (26,083 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 48%] Downloading update (27,785 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 51%] Downloading update (29,599 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 54%] Downloading update (31,278 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 58%] Downloading update (33,165 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 61%] Downloading update (34,968 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 64%] Downloading update (36,807 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 68%] Downloading update (37,798 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 70%] Downloading update (38,769 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 72%] Downloading update (39,657 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 73%] Downloading update (40,609 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 75%] Downloading update (41,511 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 77%] Downloading update (42,404 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 78%] Downloading update (43,341 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 80%] Downloading update (44,424 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 82%] Downloading update (45,368 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 84%] Downloading update (46,232 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 85%] Downloading update (47,170 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 87%] Downloading update (48,154 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 89%] Downloading update (49,161 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 91%] Downloading update (50,152 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 93%] Downloading update (51,070 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 94%] Downloading update (52,071 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 96%] Downloading update (53,163 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [ 98%] Downloading update (53,822 of 53,822 KB)...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [100%] Download complete.
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Extracting package...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Extracting package...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Extracting package...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Extracting package...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Installing update...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Cleaning up...
valheim-server
Dec 14 20:59:15 /supervisord: valheim-updater [----] Update complete, launching Steamcmd...
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater Redirecting stderr to '/home/valheim/Steam/logs/stderr.txt'
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater [ 0%] Checking for available updates...
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater [----] Verifying installation...
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater Steam Console Client (c) Valve Corporation - version 1637624355
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater -- type 'quit' to exit --
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater Loading Steam API...OK
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater
valheim-server
Dec 14 20:59:17 /supervisord: valheim-updater Connecting anonymously to Steam Public...
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater OK
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater Waiting for client config...OK
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater Waiting for user info...
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater OK
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater ^[[33;1mPlease use force_install_dir before logon!
valheim-server
Dec 14 20:59:24 /supervisord: valheim-updater ^[[0m
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x3) reconfiguring, progress: 0.00 (0 / 0)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x3) reconfiguring, progress: 0.00 (0 / 0)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 14.74 (160178867 / 1086355123)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 32.97 (358184275 / 1086355123)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 51.48 (559304947 / 1086355123)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 68.95 (749011023 / 1086355123)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 86.88 (943824246 / 1086355123)
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater Success! App '896660' fully installed.
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater .d..t...... ./
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater INFO - Valheim Server is already the latest version
valheim-server
Dec 14 20:59:39 /supervisord: valheim-updater DEBUG - [38] - Writing file to start Valheim server
valheim-server
2021-12-14 20:59:40,190 INFO spawned: 'valheim-server' with pid 137
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server INFO - Running Valheim Server
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server DEBUG - [137] - Server config is name: ZadupieNowe3, port: 2456/udp, world: ZadupieNowe3, public: 1, mod: none
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server DEBUG - [137] - Waiting for server to listen on UDP port 2456
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237130 147 main.go:76] Configuring Valheim server log filter
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237514 147 main.go:96] Removing log lines starting with '(Filename:'
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237560 147 main.go:89] Removing log lines matching ' '
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237589 147 main.go:125] Removing invalid UTF-8 chars: true
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237627 147 main.go:122] Removing empty log lines: true
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server I1214 20:59:40.237667 147 main.go:96] Removing log lines starting with 'src/steamnetworkingsockets/clientlib/steamnetworkingsockets_lowlevel.cpp'
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Found path: /opt/valheim/server/valheim_server.x86_64
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Mono path[0] = '/opt/valheim/server/valheim_server_Data/Managed'
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Mono config path = '/opt/valheim/server/valheim_server_Data/MonoBleedingEdge/etc'
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Preloaded 'libsteam_api.so'
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Initialize engine version: 2019.4.31f1 (bd5abf232a62)
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server [Subsystems] Discovering subsystems at path /opt/valheim/server/valheim_server_Data/UnitySubsystems
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Forcing GfxDevice: Null
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server GfxDevice: creating device client; threaded=0
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server NullGfxDevice:
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Version: NULL 1.0 [1.0]
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Renderer: Null Device
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Vendor: Unity Technologies
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server Begin MonoManager ReloadAssembly
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server - Completed reload, in 0.193 seconds
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server UnloadTime: 2.195291 ms
valheim-server
Dec 14 20:59:40 /supervisord: valheim-server 12/14/2021 20:59:40: Starting to load scene:start
valheim-server
Dec 14 20:59:41 /supervisord: valheim-server Couldn't create a Convex Mesh from source mesh "default" within the maximum polygons limit (256). The partial hull will be used. Consider simplifying your mesh.
valheim-server
Dec 14 20:59:41 /supervisord: valheim-server Couldn't create a Convex Mesh from source mesh "default" within the maximum polygons limit (256). The partial hull will be used. Consider simplifying your mesh.
valheim-server
Dec 14 20:59:45 /supervisord: valheim-server DEBUG - [137] - Waiting for server to listen on UDP port 2456
valheim-server
2021-12-14 20:59:50,253 INFO success: valheim-server entered RUNNING state, process has stayed up for > than 10 seconds (startsecs)
valheim-server
Dec 14 20:59:50 /supervisord: valheim-server DEBUG - [137] - Waiting for server to listen on UDP port 2456
valheim-server
Dec 14 20:59:50 /supervisord: valheim-updater valheim-server: started
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server HDR Render Texture not supported, disabling HDR on reflection probe.
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server HDR Render Texture not supported, disabling HDR on reflection probe.
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server Unloading 6 Unused Serialized files (Serialized files now loaded: 0)
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server UnloadTime: 20.210402 ms
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server Only custom filters can be played. Please add a custom filter or an audioclip to the audiosource (Amb_MainMenu).
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server HDR Render Texture not supported, disabling HDR on reflection probe.
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server 12/14/2021 20:59:54: Valheim version:0.206.5
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server 12/14/2021 20:59:54: Render threading mode:SingleThreaded
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server 12/14/2021 20:59:54: Get create world ZadupieNowe3
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server 12/14/2021 20:59:54: Using environment steamid 892970
valheim-server
Dec 14 20:59:54 /supervisord: valheim-server 12/14/2021 20:59:54: Using steam APPID:892970
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server [S_API] SteamAPI_Init(): Loaded local 'steamclient.so' OK.
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server CAppInfoCacheReadFromDiskThread took 5 milliseconds to initialize
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server Setting breakpad minidump AppID = 892970
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server [S_API FAIL] Tried to access Steam interface SteamNetworkingUtils003 before SteamAPI_Init succeeded.
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server 12/14/2021 20:59:55: Server ID 90071992547409920
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server 12/14/2021 20:59:55: Authentication:k_ESteamNetworkingAvailability_Waiting
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server 12/14/2021 20:59:55: Steam game server initialized
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server DEBUG - [137] - Waiting for server to listen on UDP port 2456
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server 12/14/2021 20:59:55: Missing audio clip in music respawn
valheim-server
Dec 14 20:59:55 /supervisord: valheim-server 12/14/2021 20:59:55: Builder started
valheim-server
Dec 14 20:59:58 /supervisord: valheim-server 12/14/2021 20:59:58: Loaded localization CSV:localization language:English
valheim-server
Dec 14 20:59:58 /supervisord: valheim-server 12/14/2021 20:59:58: Loaded localization CSV:localization_extra language:English
valheim-server
Dec 14 20:59:58 /supervisord: valheim-server 12/14/2021 20:59:58: Game server connected
valheim-server
Dec 14 20:59:58 /supervisord: valheim-server 12/14/2021 20:59:58: UI Group status changed Menu = True
valheim-server
Dec 14 20:59:59 /supervisord: valheim-server Unloading 17 unused Assets to reduce memory usage. Loaded Objects now: 98237.
valheim-server
Dec 14 20:59:59 /supervisord: valheim-server Total: 162.525019 ms (FindLiveObjects: 10.330911 ms CreateObjectMapping: 27.802555 ms MarkObjects: 123.002986 ms DeleteObjects: 1.387298 ms)
valheim-server
Dec 14 20:59:59 /supervisord: valheim-server Unloading 6 Unused Serialized files (Serialized files now loaded: 0)
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server UnloadTime: 30.536926 ms
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server HDR Render Texture not supported, disabling HDR on reflection probe.
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server HDR Render Texture not supported, disabling HDR on reflection probe.
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server 12/14/2021 21:00:00: Zonesystem Awake 272
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server 12/14/2021 21:00:00: DungeonDB Awake 272
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server 12/14/2021 21:00:00: Registering lobby
valheim-server
Dec 14 21:00:00 /supervisord: valheim-server DEBUG - [137] - Server is now listening on UDP port 2456
valheim-server
Dec 14 21:00:01 CRON[216]: pam_unix(cron:session): session opened for user root by (uid=0)
valheim-server
Dec 14 21:00:01 CRON[215]: pam_unix(cron:session): session opened for user root by (uid=0)
valheim-server
Dec 14 21:00:01 CRON[217]: (root) CMD ([ -f "/var/run/valheim/valheim-backup.pid" ] && kill -HUP $(cat /var/run/valheim/valheim-backup.pid))
valheim-server
Dec 14 21:00:01 CRON[218]: (root) CMD ([ -f "/var/run/valheim/valheim-updater.pid" ] && kill -HUP $(cat /var/run/valheim/valheim-updater.pid))
valheim-server
Dec 14 21:00:01 CRON[216]: pam_unix(cron:session): session closed for user root
valheim-server
Dec 14 21:00:01 CRON[215]: pam_unix(cron:session): session closed for user root
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - Received signal to check for update
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - Kernel: Linux valheim-server-777fbdff84-8m6nm 5.4.0-91-generic #102-Ubuntu SMP Fri Nov 5 16:31:28 UTC 2021 x86_64 GNU/Linux
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - Found CPU with 800.014 MHz
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - Memory total/free/available: 16259204/7437392/13273444
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - Storage configuration:
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater Filesystem Size Used Avail Use% Mounted on
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater overlay 467G 35G 412G 8% /
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater /dev/longhorn/pvc-30e49edd-9c3d-41f4-8093-29c36a536359 3.9G 50M 3.9G 2% /config
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater /dev/longhorn/pvc-adb16d3d-23d0-4ac9-b8f2-d6f012e1157c 4.9G 2.1G 2.8G 43% /opt/valheim
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater grep:
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater /etc/mtab: No such file or directory
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater DEBUG - [38] - No players connected to Valheim server
valheim-server
Dec 14 21:00:08 /supervisord: valheim-updater INFO - Downloading/updating/validating Valheim server from Steam
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater Redirecting stderr to '/home/valheim/Steam/logs/stderr.txt'
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater [ 0%] Checking for available updates...
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater [----] Verifying installation...
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater Steam Console Client (c) Valve Corporation - version 1637624355
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater -- type 'quit' to exit --
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater Loading Steam API...OK
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater
valheim-server
Dec 14 21:00:10 /supervisord: valheim-updater Connecting anonymously to Steam Public...
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater OK
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater Waiting for client config...OK
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater Waiting for user info...
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater OK
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater ^[[33;1mPlease use force_install_dir before logon!
valheim-server
Dec 14 21:00:12 /supervisord: valheim-updater ^[[0m
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup DEBUG - [73] - Received signal to backup world
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup INFO - Backing up Valheim server worlds to /config/backups/worlds-20211214-210014.zip
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup adding: worlds/
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup (stored 0%)
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.db
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup (deflated 51%)
valheim-server
Dec 14 21:00:14 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.db.old
valheim-server
Dec 14 21:00:16 /supervisord: valheim-server 12/14/2021 21:00:16: Audioman already exist, destroying self
valheim-server
Dec 14 21:00:17 /supervisord: valheim-server Unloading 513 unused Assets to reduce memory usage. Loaded Objects now: 98828.
valheim-server
Dec 14 21:00:17 /supervisord: valheim-server Total: 221.474551 ms (FindLiveObjects: 14.176263 ms CreateObjectMapping: 28.819638 ms MarkObjects: 174.788228 ms DeleteObjects: 3.688481 ms)
valheim-server
Dec 14 21:00:17 /supervisord: valheim-backup (deflated 68%)
valheim-server
Dec 14 21:00:17 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.fwl.old (deflated 2%)
valheim-server
Dec 14 21:00:17 /supervisord: valheim-backup adding: worlds/ZadupieNowe3.fwl
valheim-server
Dec 14 21:00:17 /supervisord: valheim-backup (deflated 4%)
valheim-server
Dec 14 21:00:17 /supervisord: valheim-backup INFO - Removing backups older than 3 days
valheim-server
Dec 14 21:00:29 /supervisord: valheim-server 12/14/2021 21:00:29: Zonesystem Start 272
valheim-server
Dec 14 21:00:31 /supervisord: valheim-server 12/14/2021 21:00:31: Added 3 locations, 0 vegetations, 0 environments, 0 biome env-setups from locations_cp1
valheim-server
Dec 14 21:00:31 /supervisord: valheim-server 12/14/2021 21:00:31: DungeonDB Start 272
valheim-server
Dec 14 21:00:32 /supervisord: valheim-server 12/14/2021 21:00:32: Load world ZadupieNowe3
valheim-server
Dec 14 21:00:32 /supervisord: valheim-server 12/14/2021 21:00:32: Loading 81 zdos , my id 149102669 data version:28
valheim-server
Dec 14 21:00:32 /supervisord: valheim-server 12/14/2021 21:00:32: Loaded 0 dead zdos
valheim-server
Dec 14 21:00:32 /supervisord: valheim-server 12/14/2021 21:00:32: Removed 0 OLD generated ZDOS
valheim-server
Dec 14 21:00:32 /supervisord: valheim-server 12/14/2021 21:00:32: Loaded 7380 locations
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 0.00 (5346 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 4.87 (52918888 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 12.28 (133438320 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 20.16 (218994352 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 30.83 (334951464 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 42.73 (464175656 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 54.24 (589280716 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 64.15 (696848460 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 74.88 (813444044 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 85.83 (932445324 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Update state (0x5) verifying install, progress: 97.14 (1055306924 / 1086355123)
valheim-server
Dec 14 21:00:32 /supervisord: valheim-updater Success! App '896660' fully installed.
valheim-server
Dec 14 21:00:33 /supervisord: valheim-updater .d..t...... ./
valheim-server
Dec 14 21:00:33 /supervisord: valheim-updater INFO - Valheim Server is already the latest version
kamilgregorczyk commented 2 years ago
root@valheim-server-5b6bdc7646-8q5lq:/# echo $WORLD_NAME
ZadupieNowe3
kamilgregorczyk commented 2 years ago
root@valheim-server-5b6bdc7646-8q5lq:/config/worlds# ps ax | cat
    PID TTY      STAT   TIME COMMAND
      1 ?        Ss     1:16 /usr/bin/python3 /usr/local/bin/supervisord -c /usr/local/etc/supervisord.conf
     28 ?        S      0:00 /usr/local/sbin/syslogd -n -S -t -O -
     29 ?        S      0:00 /usr/sbin/cron -f
     40 ?        S      0:29 /bin/bash /usr/local/bin/valheim-updater
     73 ?        S      0:12 /bin/bash /usr/local/bin/valheim-backup
    165 pts/0    Ss+    0:00 bash
  45454 ?        S      0:00 /bin/bash /usr/local/bin/valheim-server
  45458 ?        Sl   348:46 /opt/valheim/server/valheim_server.x86_64 -nographics -batchmode -name ZadupieNowe3 -port 2456 -world ZadupieNowe3 -public 1 -password online13
  45464 ?        S      0:00 /bin/bash /usr/local/bin/valheim-server
  45465 ?        Sl     0:01 /usr/local/bin/valheim-logfilter -logtostderr -v 2
  66836 pts/1    Ss     0:00 /bin/bash
  68057 ?        S      0:00 sleep 20
  68061 ?        S      0:00 sleep 9
  68062 pts/1    R+     0:00 ps ax
  68063 pts/1    S+     0:00 cat
kamilgregorczyk commented 2 years ago

got it working by doing

chmod 777 ./Zadupie* and chwown valheim ./Zadupie*

weird that there are no permissions issues/warnings

root@valheim-server-5b6bdc7646-6bnrt:/config/worlds# ls -lah
total 15M
drwxr-xr-x 2 root root 4.0K Dec 17 09:03 .
drwxr-xr-x 5 root root 4.0K Dec 17 09:01 ..
-rw-r--r-- 1 root root  15M Dec 17 09:03 ZadupieNowe3.db
-rw-r--r-- 1 root root   48 Dec 17 09:03 ZadupieNowe3.fwl
kamilgregorczyk commented 2 years ago

I actually found a bug, it is only possible to restore server from backup or import save from steam to dedicated server on a fresh instance that wasn't initialized with a new world previously. I tried putting my save into an existing server and it didn't work even though permissions were set. I had to delete whole sever, spin it up and very fast put my existing world into /worlds dir, before new one would be generated.

lloesche commented 2 years ago

Can you check if #438 solves the issue for you?

havedill commented 2 years ago

I'm experiencing this right now, even with the backup of the .fwl files.

The way i resolved was: Delete the docker container entirely (i use unraid). I put my backups in place on my local storage, Started a new container, and whatever permissions the initial container changes it to on start up resolved my issues.

Note, i tried manually chmod/chowning the exact same permissions prior. So it must be something not visible from the host OS?.

Note during my debugging, i tested with chmod 666, 777, 770, and the nobody:users ownership. Still no dice. Only thing that worked was re-creating the actual container like kamilgregorczyk did

########## PRE-NEW CONTAINER, ONLY COPIED MY BACKUPS IN HERE. DID NOT CHMOD'S
root@unraid:/mnt/fastcache/appdata/valheim/.config/unity3d/IronGate/Valheim/worlds# ls -alth
total 66M
drwxrwx--- 1 nobody users 116 Apr  1 05:28 ./
-rw-r--r-- 1 nobody users 33M Apr  1 05:28 Dedicated.db.old
-rw-r--r-- 1 nobody users  45 Apr  1 05:28 Dedicated.fwl
-rw-r--r-- 1 nobody users  45 Apr  1 05:28 Dedicated.fwl.old
-rw-r--r-- 1 nobody users 33M Apr  1 05:28 Dedicated.db
drwxrwx--- 1 nobody users 110 Mar 22 20:02 ../

######### NEW CONTAINER STARTED, PERMISSIONS AUTOMATICALLY CHANGED - WORKING!
root@unraid:/mnt/fastcache/appdata/valheim/.config/unity3d/IronGate/Valheim/worlds# ls -alth
total 66M
drwxrwx--- 1 nobody users 116 Apr  1 05:28 ./
-rwxrwx--- 1 nobody users 33M Apr  1 05:28 Dedicated.db.old*
-rwxrwx--- 1 nobody users  45 Apr  1 05:28 Dedicated.fwl*
-rwxrwx--- 1 nobody users  45 Apr  1 05:28 Dedicated.fwl.old*
-rwxrwx--- 1 nobody users 33M Apr  1 05:28 Dedicated.db*
drwxrwx--- 1 nobody users 110 Mar 22 20:02 ../
Cevap05 commented 2 years ago

-rwxrwx--- 1 nobody users 33M Apr 1 05:28 Dedicated.db.old -rwxrwx--- 1 nobody users 45 Apr 1 05:28 Dedicated.fwl -rwxrwx--- 1 nobody users 45 Apr 1 05:28 Dedicated.fwl.old* -rwxrwx-

Hey I believe I am having the same issue as you, despite hours of trying to fix it. I've tried transferring over an old .db .fwl file and no luck. I've created a new one and transferred them over, no luck. I've tried to change permissions before and no luck. I've deleted all containers, restarted new one using docker compose and did not change any permissions, also no luck. Only thing that seems to work is letting container startup make its own .db and .fwl file. Any ideas how I could fix it so I could import my own world? Thanks!

Kurtchekov commented 10 months ago

Had the same problem yesterday, I've managed to find the real location of the save files at /home/valheim/.config/unity3d/IronGate/Valheim/worlds_local inside the docker container. Deleted the files in there and replaced with a different world and it worked!