Oct 15 18:01:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Oct 15 18:01:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:01:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:01:01 volumio go-librespot[234297]: go-librespot daemon starting... Oct 15 18:01:01 volumio go-librespot[234298]: time="2026-10-15T18:01:01+05:30" level=info msg="running go-librespot 0.7.1" Oct 15 18:01:01 volumio go-librespot[234298]: time="2026-10-15T18:01:01+05:30" level=debug msg="app state loaded" Oct 15 18:01:01 volumio go-librespot[234298]: time="2026-10-15T18:01:01+05:30" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 18:01:05 volumio volumio[232773]: info: [jellyfin-poller] Polled http://10.10.1.104:8096: offline Oct 15 18:01:31 volumio go-librespot[234298]: time="2026-10-15T18:01:31+05:30" 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)" Oct 15 18:01:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 18:01:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 18:01:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Oct 15 18:01:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:01:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:01:34 volumio go-librespot[234399]: go-librespot daemon starting... Oct 15 18:01:34 volumio go-librespot[234400]: time="2026-10-15T18:01:34+05:30" level=info msg="running go-librespot 0.7.1" Oct 15 18:01:34 volumio go-librespot[234400]: time="2026-10-15T18:01:34+05:30" level=debug msg="app state loaded" Oct 15 18:01:34 volumio go-librespot[234400]: time="2026-10-15T18:01:34+05:30" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 18:01:39 volumio volumio[232773]: info: [jellyfin-poller] Polled http://10.10.1.104:8096: offline Oct 15 18:02:04 volumio go-librespot[234400]: time="2026-10-15T18:02:04+05:30" 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\": dial tcp: lookup apresolve.spotify.com: i/o timeout (Client.Timeout exceeded while awaiting headers)" Oct 15 18:02:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 18:02:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 18:02:06 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 15 18:02:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Oct 15 18:02:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:02:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 15 18:02:07 volumio go-librespot[234488]: go-librespot daemon starting... Oct 15 18:02:07 volumio go-librespot[234489]: time="2026-10-15T18:02:07+05:30" level=info msg="running go-librespot 0.7.1" Oct 15 18:02:07 volumio go-librespot[234489]: time="2026-10-15T18:02:07+05:30" level=debug msg="app state loaded" Oct 15 18:02:07 volumio go-librespot[234489]: time="2026-10-15T18:02:07+05:30" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 18:02:12 volumio volumio[232773]: info: [jellyfin-poller] Polled http://10.10.1.104:8096: offline Oct 15 18:02:34 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 15 18:02:35 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 15 18:02:35 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 15 18:02:35 volumio go-librespot[234489]: time="2026-10-15T18:02:35+05:30" level=debug msg="new websocket client" Oct 15 18:02:35 volumio volumio[232773]: info: Connection to go-librespot Websocket established Oct 15 18:02:35 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 18:02:35 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 15 18:02:35 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 15 18:02:35 volumio go-librespot[234489]: time="2026-10-15T18:02:35+05:30" 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\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 15 18:02:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 18:02:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 18:02:35 volumio volumio[232773]: info: Connection to go-librespot Websocket closed Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Oct 15 18:02:36 volumio volumio[232773]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Oct 15 18:02:36 volumio volumio[232773]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:36 volumio volumio[232773]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin bluetooth to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin multiroom to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin metavolumio to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin cd_controller to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 15 18:02:37 volumio volumio[232773]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:37 volumio volumio[232773]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:37 volumio volumio[232773]: info: Starting MyVolumio Remote Streaming Endpoints Oct 15 18:02:37 volumio volumio[232773]: info: MyVolumio login type: Token Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 15 18:02:37 volumio volumio[232773]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 15 18:02:38 volumio volumio[232773]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 15 18:02:38 volumio volumio[232773]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 15 18:02:38 volumio volumio[232773]: info: Streaming services startup Oct 15 18:02:38 volumio volumio[232773]: info: Starting Streaming Daemon Oct 15 18:02:38 volumio sudo[234576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 15 18:02:38 volumio sudo[234576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 18:02:38 volumio volumio[232773]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 15 18:02:38 volumio sudo[234576]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:38 volumio volumio[232773]: error: Cannot start Volumio Streaming Daemon Oct 15 18:02:38 volumio volumio[232773]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 15 18:02:38 volumio volumio[232773]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 15 18:02:38 volumio volumio[232773]: error: MyVolumio Custom Token format not valid, refreshing it Oct 15 18:02:38 volumio volumio[232773]: info: Getting Spotify volume Oct 15 18:02:38 volumio volumio[232773]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:38 volumio volumio[232773]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 18:02:38 volumio volumio[232773]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 15 18:02:38 volumio volumio[232773]: errno: -111, Oct 15 18:02:38 volumio volumio[232773]: code: 'ECONNREFUSED', Oct 15 18:02:38 volumio volumio[232773]: syscall: 'connect', Oct 15 18:02:38 volumio volumio[232773]: address: '127.0.0.1', Oct 15 18:02:38 volumio volumio[232773]: port: 9879, Oct 15 18:02:38 volumio volumio[232773]: response: undefined Oct 15 18:02:38 volumio volumio[232773]: } Oct 15 18:02:38 volumio volumio[232773]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:38 volumio sudo[234601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 18:01' Oct 15 18:02:38 volumio sudo[234601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"