Feb 10 22:01:00 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 22:01:00 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 22:01:00 volumio volumio5-onboarding[3043]: time=2026-02-10T22:01:00.787+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:01:00 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 10 22:01:01 volumio volumio[2474]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Feb 10 22:01:01 volumio volumio[2474]: info: ------------------------------------------- Feb 10 22:01:01 volumio volumio[2474]: info: ----- MyVolumio plugins startup ---- Feb 10 22:01:01 volumio volumio[2474]: info: ------------------------------------------- Feb 10 22:01:01 volumio volumio[2474]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 10 22:01:05 volumio sudo[3057]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 10 22:01:06 volumio sudo[3057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:01:06 volumio volumio[2474]: info: Spotify config file written Feb 10 22:01:08 volumio sudo[3057]: pam_unix(sudo:session): session closed for user root Feb 10 22:01:09 volumio sudo[3064]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 10 22:01:09 volumio sudo[3064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:01:09 volumio volumio-remote-updater[693]: [2026-02-10 22:01:09] [connect] Successful connection Feb 10 22:01:11 volumio volumio5-onboarding[3043]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:46736->127.0.0.1:3000: i/o timeout Feb 10 22:01:11 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:01:11 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:12 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.181s CPU time. Feb 10 22:01:12 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Feb 10 22:01:12 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 29. Feb 10 22:01:12 volumio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:12 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.181s CPU time. Feb 10 22:01:14 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:14 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Feb 10 22:01:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:01:15 volumio systemd[1]: go-librespot-daemon.service: Consumed 7.831s CPU time. Feb 10 22:01:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:01:16 volumio go-librespot[3078]: go-librespot daemon starting... Feb 10 22:01:18 volumio sudo[3064]: pam_unix(sudo:session): session closed for user root Feb 10 22:01:19 volumio volumio5-onboarding[3070]: time=2026-02-10T22:01:18.987+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:01:19 volumio go-librespot[3088]: time="2026-02-10T22:01:19+01:00" level=info msg="running go-librespot 0.6.2" Feb 10 22:01:19 volumio go-librespot[3088]: time="2026-02-10T22:01:19+01:00" level=debug msg="app state loaded" Feb 10 22:01:19 volumio go-librespot[3088]: time="2026-02-10T22:01:19+01:00" level=debug msg="stored credentials not found" Feb 10 22:01:21 volumio go-librespot[3088]: time="2026-02-10T22:01:21+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 10 22:01:22 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 22:01:22 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 10 22:01:25 volumio volumio-remote-updater[693]: [2026-02-10 22:01:25] [connect] Successful connection Feb 10 22:01:26 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:28 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:29 volumio volumio5-onboarding[3070]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:46756->127.0.0.1:3000: i/o timeout Feb 10 22:01:30 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:01:30 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 10 22:01:30 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.301s CPU time. Feb 10 22:01:30 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 30. Feb 10 22:01:30 volumio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:30 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.301s CPU time. Feb 10 22:01:31 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 22:01:31 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 10 22:01:33 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:34 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:34 volumio volumio5-onboarding[3134]: time=2026-02-10T22:01:34.558+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:01:51 volumio volumio-remote-updater[693]: [2026-02-10 22:01:50] [connect] Successful connection Feb 10 22:01:51 volumio volumio5-onboarding[3134]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: dial tcp 127.0.0.1:3000: i/o timeout Feb 10 22:01:51 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:01:51 volumio volumio[2474]: info: No need to fix Spotify hosts Feb 10 22:01:51 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 10 22:01:52 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 31. Feb 10 22:01:52 volumio go-librespot[3088]: time="2026-02-10T22:01:52+01:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" Feb 10 22:01:52 volumio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:53 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:01:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:01:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 22:01:53 volumio systemd[1]: go-librespot-daemon.service: Consumed 2.428s CPU time. Feb 10 22:01:55 volumio volumio5-onboarding[3153]: time=2026-02-10T22:01:55.177+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:01:56 volumio volumio[2474]: error: MPD error: The expression evaluated to a falsy value: Feb 10 22:01:56 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:01:56 volumio volumio[2474]: error: The expression evaluated to a falsy value: Feb 10 22:01:56 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:01:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 10 22:01:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:01:57 volumio systemd[1]: go-librespot-daemon.service: Consumed 2.428s CPU time. Feb 10 22:01:58 volumio volumio[2474]: info: Upmpdcli Daemon Started Feb 10 22:01:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:01:58 volumio volumio[2474]: info: MPD running with PID2968 Feb 10 22:01:58 volumio volumio[2474]: ,establishing connection Feb 10 22:01:58 volumio go-librespot[3176]: go-librespot daemon starting... Feb 10 22:01:59 volumio volumio[2474]: error: MyVolumio Plugin failed to start in a timely fashion Feb 10 22:01:59 volumio volumio[2474]: [Metrics] CommandRouter: 402s 459.62ms Feb 10 22:01:59 volumio volumio[2474]: info: CoreCommandRouter::volumiosetStartupVolume Feb 10 22:01:59 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 22:01:59 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 22:01:59 volumio volumio[2474]: info: CoreCommandRouter::Close All Modals sent Feb 10 22:02:00 volumio volumio[2474]: info: CoreCommandRouter::Close All Modals sent Feb 10 22:02:00 volumio go-librespot[3180]: time="2026-02-10T22:02:00+01:00" level=info msg="running go-librespot 0.6.2" Feb 10 22:02:00 volumio go-librespot[3180]: time="2026-02-10T22:02:00+01:00" level=debug msg="app state loaded" Feb 10 22:02:00 volumio go-librespot[3180]: time="2026-02-10T22:02:00+01:00" level=debug msg="stored credentials not found" Feb 10 22:02:01 volumio volumio[2474]: error: updateQueue error: null Feb 10 22:02:01 volumio volumio[2474]: error: MPD error: The expression evaluated to a falsy value: Feb 10 22:02:01 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:02:03 volumio volumio[2474]: error: The expression evaluated to a falsy value: Feb 10 22:02:03 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:02:03 volumio volumio[2474]: error: MPD error: The expression evaluated to a falsy value: Feb 10 22:02:03 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:02:03 volumio volumio[2474]: error: The expression evaluated to a falsy value: Feb 10 22:02:03 volumio volumio[2474]: assert.ok(self.idling) Feb 10 22:02:03 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 10 22:02:03 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 10 22:02:04 volumio go-librespot[3180]: time="2026-02-10T22:02:04+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 10 22:02:04 volumio volumio[2474]: aplay: device_list:274: no soundcards found... Feb 10 22:02:04 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 10 22:02:04 volumio volumio[2474]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 10 22:02:06 volumio volumio-remote-updater[693]: [2026-02-10 22:02:06] [connect] Successful connection Feb 10 22:02:06 volumio volumio5-onboarding[3153]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:46798->127.0.0.1:3000: i/o timeout Feb 10 22:02:06 volumio volumio[2474]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Feb 10 22:02:06 volumio volumio[2474]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for I82801AAICH Feb 10 22:02:06 volumio volumio[2474]: aplay: main:831: audio open error: No such device Feb 10 22:02:07 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:02:07 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 10 22:02:07 volumio volumio[2474]: info: go-librespot daemon successfully initialized Feb 10 22:02:07 volumio volumio[2474]: info: BOOT COMPLETED Feb 10 22:02:07 volumio volumio[2474]: info: Starting Shairport Sync Feb 10 22:02:07 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.160s CPU time. Feb 10 22:02:07 volumio volumio[2474]: info: Starting Shairport Sync Feb 10 22:02:07 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 32. Feb 10 22:02:07 volumio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:02:07 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.160s CPU time. Feb 10 22:02:08 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:02:09 volumio volumio[2474]: info: Starting Shairport Sync Feb 10 22:02:11 volumio volumio[2474]: error: updateQueue error: null Feb 10 22:02:11 volumio volumio5-onboarding[3209]: time=2026-02-10T22:02:11.666+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:02:11 volumio sudo[3213]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 22:02:11 volumio sudo[3213]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:02:12 volumio volumio[2474]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 10 22:02:13 volumio volumio[2474]: info: Discovery: adding 71b33042-121f-4203-985d-a515201f3c99 Feb 10 22:02:13 volumio volumio[2474]: info: Discovery: Found device Volumio Feb 10 22:02:13 volumio volumio[2474]: info: CoreCommandRouter::volumioGetState Feb 10 22:02:13 volumio sudo[3220]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 22:02:14 volumio volumio[2474]: info: CorePlayQueue::getTrack 0 Feb 10 22:02:14 volumio sudo[3220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:02:14 volumio sudo[3233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 22:02:14 volumio sudo[3233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:02:14 volumio volumio[2474]: info: Discovery: this is already registered, 71b33042-121f-4203-985d-a515201f3c99 Feb 10 22:02:14 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 10 22:02:14 volumio volumio[2474]: info: Discovery: Found device Volumio Feb 10 22:02:15 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 10 22:02:15 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:15 volumio systemd[1]: shairport-sync.service: Consumed 4.329s CPU time. Feb 10 22:02:15 volumio volumio[2474]: info: CoreCommandRouter::volumioGetState Feb 10 22:02:15 volumio volumio[2474]: info: CorePlayQueue::getTrack 0 Feb 10 22:02:16 volumio volumio[2474]: info: Initializing connection to go-librespot Websocket Feb 10 22:02:17 volumio volumio[2474]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 22:02:17 volumio ntpd[1043]: PROTO: 212.6.50.243 unlink local addr 192.168.3.102 -> Feb 10 22:02:17 volumio volumio[2474]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Feb 10 22:02:17 volumio volumio[2474]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Feb 10 22:02:17 volumio volumio[2474]: at new NodeError (node:internal/errors:405:5) Feb 10 22:02:17 volumio volumio[2474]: at assert (node:internal/assert:14:11) Feb 10 22:02:17 volumio volumio[2474]: at internalConnectMultiple (node:net:1118:3) Feb 10 22:02:17 volumio volumio[2474]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Feb 10 22:02:17 volumio volumio[2474]: at listOnTimeout (node:internal/timers:575:11) Feb 10 22:02:17 volumio volumio[2474]: at process.processTimers (node:internal/timers:514:7) { Feb 10 22:02:17 volumio volumio[2474]: code: 'ERR_INTERNAL_ASSERTION' Feb 10 22:02:17 volumio volumio[2474]: } Feb 10 22:02:17 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 10 22:02:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 10 22:02:18 volumio sudo[3213]: pam_unix(sudo:session): session closed for user root Feb 10 22:02:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:18 volumio volumio[2474]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 22:02:18 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:19 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 10 22:02:19 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 10 22:02:19 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:19 volumio sudo[3233]: pam_unix(sudo:session): session closed for user root Feb 10 22:02:20 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 10 22:02:20 volumio sudo[3220]: pam_unix(sudo:session): session closed for user root Feb 10 22:02:21 volumio ntpd[1043]: PROTO: 5.249.149.252 unlink local addr 192.168.3.102 -> Feb 10 22:02:21 volumio volumio-remote-updater[693]: [2026-02-10 22:02:21] [connect] Successful connection Feb 10 22:02:22 volumio volumio5-onboarding[3209]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:46824->127.0.0.1:3000: i/o timeout Feb 10 22:02:22 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:02:22 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 10 22:02:22 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.533s CPU time. Feb 10 22:02:23 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 33. Feb 10 22:02:23 volumio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:02:23 volumio systemd[1]: volumio5-onboarding.service: Consumed 1.533s CPU time. Feb 10 22:02:23 volumio bash[2809]: setdatetime-helper: all HTTPS Date fallbacks failed Feb 10 22:02:24 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 10 22:02:24 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 10 22:02:25 volumio ntpd[1043]: PROTO: 31.207.113.74 unlink local addr 192.168.3.102 -> Feb 10 22:02:26 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 10 22:02:26 volumio systemd[1]: setdatetime-helper.service: Consumed 19.507s CPU time. Feb 10 22:02:27 volumio volumio5-onboarding[3291]: time=2026-02-10T22:02:27.562+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 10 22:02:29 volumio go-librespot[3180]: time="2026-02-10T22:02:29+01:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": net/http: TLS handshake timeout" Feb 10 22:02:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 10 22:02:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 22:02:29 volumio systemd[1]: go-librespot-daemon.service: Consumed 3.826s CPU time. Feb 10 22:02:32 volumio ntpd[1043]: PROTO: 80.211.238.32 unlink local addr 192.168.3.102 -> Feb 10 22:02:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Feb 10 22:02:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:02:33 volumio systemd[1]: go-librespot-daemon.service: Consumed 3.826s CPU time. Feb 10 22:02:35 volumio sudo[3318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-10 22:01' Feb 10 22:02:35 volumio sudo[3318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 10 22:02:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 22:02:35 volumio go-librespot[3320]: go-librespot daemon starting... PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"