Aug 17 07:02:00 hipi volumio[1181]: error: MyVolumio Plugin failed to start in a timely fashion Aug 17 07:02:00 hipi volumio[1181]: [Metrics] CommandRouter: 65s 96.73ms Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::volumiosetStartupVolume Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 07:02:00 hipi volumio[1181]: info: VolumeController:: Setting startup Volume 90 Aug 17 07:02:00 hipi volumio[1181]: info: VolumeController::SetAlsaVolume90 Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::Close All Modals sent Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::Close All Modals sent Aug 17 07:02:00 hipi volumio[1181]: info: CoreStateMachine::pushState Aug 17 07:02:00 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:02:00 hipi volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 17 07:02:01 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 17 07:02:01 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 17 07:02:01 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 17 07:02:01 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:02:01 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:02:05 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Aug 17 07:02:05 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:05 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:05 hipi upmpdcli[2136]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:02:05 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:05 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:02:07 hipi volumio[1181]: info: BOOT COMPLETED Aug 17 07:02:07 hipi bash[1925]: setdatetime-helper: all HTTPS Date fallbacks failed Aug 17 07:02:07 hipi systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 17 07:02:07 hipi systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 17 07:02:09 hipi volumio[1181]: info: Discovery: adding b8f65b55-d881-41f3-9133-e34fb723d5b9 Aug 17 07:02:09 hipi volumio[1181]: info: Discovery: Found device hipi Aug 17 07:02:09 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:02:09 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:02:09 hipi volumio[1181]: info: Discovery: this is already registered, b8f65b55-d881-41f3-9133-e34fb723d5b9 Aug 17 07:02:09 hipi volumio[1181]: info: Discovery: Found device hipi Aug 17 07:02:09 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:02:09 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:02:17 hipi volumio[1181]: verbose: New Socket.io Connection to 192.168.0.40:3000 from 192.168.0.204 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 17 07:02:18 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 17 07:02:18 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:02:18 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:02:19 hipi go-librespot[2084]: time="2026-08-17T07:02:19-04: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\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Aug 17 07:02:19 hipi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:19 hipi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 17 07:02:20 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Aug 17 07:02:20 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:20 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:20 hipi upmpdcli[2158]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:02:20 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:20 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:02:21 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "reconnect" Aug 17 07:02:21 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: subscribed to status events for player ID "b8:27:eb:1e:a1:69" Aug 17 07:02:22 hipi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Aug 17 07:02:22 hipi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:02:22 hipi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:02:22 hipi go-librespot[2168]: go-librespot daemon starting... Aug 17 07:02:22 hipi go-librespot[2169]: time="2026-08-17T07:02:22-04:00" level=info msg="running go-librespot 0.7.1" Aug 17 07:02:22 hipi go-librespot[2169]: time="2026-08-17T07:02:22-04:00" level=debug msg="app state loaded" Aug 17 07:02:22 hipi go-librespot[2169]: time="2026-08-17T07:02:22-04:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 17 07:02:23 hipi ntpd[1029]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Aug 17 07:02:23 hipi ntpd[1029]: DNS: dns_check: DNS error: -11, System error Aug 17 07:02:23 hipi ntpd[1029]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Aug 17 07:02:23 hipi ntpd[1029]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Aug 17 07:02:32 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "client" Aug 17 07:02:32 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "client" Aug 17 07:02:33 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "client" Aug 17 07:02:33 hipi volumio[1181]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=2f97f0356f3ee096db44da12e2aa4465" http://updates.volumio.org/downloader-v1/track-device Aug 17 07:02:33 hipi volumio[1181]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 17 07:02:33 hipi volumio[1181]: Dload Upload Total Spent Left Speed Aug 17 07:02:33 hipi volumio[1181]: [2.2K blob data] Aug 17 07:02:33 hipi volumio[1181]: retrying in 5 seconds, trial 1 Aug 17 07:02:33 hipi volumio[1181]: info: Volumio Calling Home Aug 17 07:02:33 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "client" Aug 17 07:02:36 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Aug 17 07:02:36 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:36 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:36 hipi upmpdcli[2196]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:02:36 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:36 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:02:36 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "reconnect" Aug 17 07:02:36 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: subscribed to status events for player ID "cc:cc:84:10:07:52" Aug 17 07:02:36 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:36 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:37 hipi volumio[1181]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo ENOTFOUND oauth-performer.prod.vlmapi.io Aug 17 07:02:37 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 17 07:02:49 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:49 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "reconnect" Aug 17 07:02:50 hipi volumio[1181]: info: [squeezelite_mc] Player connected to canpi (192.168.0.6): {"id":"b8:27:eb:1e:a1:69","ip":"192.168.0.240","name":"garagepi"} Aug 17 07:02:50 hipi volumio[1181]: info: [squeezelite_mc] Player connected to canpi (192.168.0.6): {"id":"cc:cc:84:10:07:52","ip":"192.168.0.6","name":"Bedroom TV"} Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: subscribed to status events for player ID "b8:27:eb:1e:a1:69" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: subscribed to status events for player ID "cc:cc:84:10:07:52" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "client" Aug 17 07:02:50 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "client" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "client" Aug 17 07:02:50 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "client" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "reconnect" Aug 17 07:02:50 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:50 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:50 hipi go-librespot[2169]: time="2026-08-17T07:02:50-04: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\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Aug 17 07:02:50 hipi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:50 hipi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 17 07:02:51 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Aug 17 07:02:51 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:51 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:02:51 hipi upmpdcli[2211]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:02:51 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:02:51 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:02:51 hipi ntpd[1029]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Aug 17 07:02:51 hipi ntpd[1029]: DNS: dns_check: DNS error: -11, System error Aug 17 07:02:51 hipi ntpd[1029]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Aug 17 07:02:51 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "disconnect" Aug 17 07:02:52 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: unsubscribed from status events for player ID "b8:27:eb:1e:a1:69" Aug 17 07:02:54 hipi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Aug 17 07:02:54 hipi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:02:54 hipi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:02:54 hipi go-librespot[2226]: go-librespot daemon starting... Aug 17 07:02:54 hipi go-librespot[2227]: time="2026-08-17T07:02:54-04:00" level=info msg="running go-librespot 0.7.1" Aug 17 07:02:54 hipi go-librespot[2227]: time="2026-08-17T07:02:54-04:00" level=debug msg="app state loaded" Aug 17 07:02:54 hipi go-librespot[2227]: time="2026-08-17T07:02:54-04:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 17 07:02:54 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "reconnect" Aug 17 07:02:54 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) CometD: subscribed to status events for player ID "b8:27:eb:1e:a1:69" Aug 17 07:02:55 hipi volumio[1181]: verbose: [squeezelite_mc] (lms-player-monitor) Got playerConnection event "play,stop,pause,playlist,mixer,sync" Aug 17 07:02:55 hipi volumio[1181]: warn: [squeezelite_mc] (lms-player-monitor) Unknown player connection message type "play,stop,pause,playlist,mixer,sync" Aug 17 07:03:05 hipi volumio[1181]: info: Discovery: adding 950868d9-c94c-47b7-9749-c9140e9de2cd Aug 17 07:03:05 hipi volumio[1181]: info: Discovery: Found device kitchenpi Aug 17 07:03:05 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.204 Aug 17 07:03:06 hipi volumio[1181]: info: Discovery: Connected to remote: 192.168.0.204 Aug 17 07:03:06 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Aug 17 07:03:06 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:03:06 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:03:06 hipi upmpdcli[2249]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:03:06 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:03:06 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:03:09 hipi volumio[1181]: verbose: New Socket.io Connection to 192.168.0.40:3000 from 192.168.0.58 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 17 07:03:09 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 17 07:03:10 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:10 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:12 hipi volumio[1181]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=2f97f0356f3ee096db44da12e2aa4465" http://updates.volumio.org/downloader-v1/track-device Aug 17 07:03:12 hipi volumio[1181]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 17 07:03:12 hipi volumio[1181]: Dload Upload Total Spent Left Speed Aug 17 07:03:12 hipi volumio[1181]: [2.2K blob data] Aug 17 07:03:12 hipi volumio[1181]: retrying in 5 seconds, trial 2 Aug 17 07:03:12 hipi volumio[1181]: info: Volumio Calling Home Aug 17 07:03:14 hipi go-librespot[2227]: time="2026-08-17T07:03:14-04:00" level=debug msg="new websocket client" Aug 17 07:03:14 hipi volumio[1181]: info: Connection to go-librespot Websocket established Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: this is already registered, 950868d9-c94c-47b7-9749-c9140e9de2cd Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: Found device kitchenpi Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: this is already registered, b8f65b55-d881-41f3-9133-e34fb723d5b9 Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: Found device hipi Aug 17 07:03:15 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:15 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: this is already registered, b8f65b55-d881-41f3-9133-e34fb723d5b9 Aug 17 07:03:15 hipi volumio[1181]: info: Discovery: Found device hipi Aug 17 07:03:15 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:15 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: adding a9d922c1-1c58-4259-8405-e2bc7cc65cba Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device headpi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.58 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: this is already registered, a9d922c1-1c58-4259-8405-e2bc7cc65cba Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device headpi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.58 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: adding b42f7d45-d35a-49b6-bc8d-8a63806da5d3 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device bellapi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.223 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: this is already registered, b42f7d45-d35a-49b6-bc8d-8a63806da5d3 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device bellapi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.223 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to 192.168.0.40:3000 from 192.168.0.223 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: this is already registered, b42f7d45-d35a-49b6-bc8d-8a63806da5d3 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device garagepi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.240 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: this is already registered, b42f7d45-d35a-49b6-bc8d-8a63806da5d3 Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Found device garagepi Aug 17 07:03:16 hipi volumio[1181]: info: Discovery: Connecting to remote: 192.168.0.240 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 17 07:03:16 hipi volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Aug 17 07:03:17 hipi volumio[1181]: info: Discovery: Connected to remote: 192.168.0.58 Aug 17 07:03:17 hipi volumio[1181]: verbose: New Socket.io Connection to 192.168.0.40:3000 from 192.168.0.240 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Aug 17 07:03:17 hipi volumio[1181]: info: Discovery: Connected to remote: 192.168.0.240 Aug 17 07:03:17 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 17 07:03:17 hipi go-librespot[2227]: time="2026-08-17T07:03:17-04: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\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Aug 17 07:03:17 hipi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:03:17 hipi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 17 07:03:17 hipi volumio[1181]: info: Connection to go-librespot Websocket closed Aug 17 07:03:17 hipi volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 17 07:03:17 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:17 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:17 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:17 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:17 hipi volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 17 07:03:17 hipi volumio[1181]: info: CorePlayQueue::getTrack 0 Aug 17 07:03:18 hipi volumio[1181]: info: Getting Spotify volume Aug 17 07:03:18 hipi volumio[1181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 07:03:18 hipi volumio[1181]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 17 07:03:18 hipi volumio[1181]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 17 07:03:18 hipi volumio[1181]: errno: -111, Aug 17 07:03:18 hipi volumio[1181]: code: 'ECONNREFUSED', Aug 17 07:03:18 hipi volumio[1181]: syscall: 'connect', Aug 17 07:03:18 hipi volumio[1181]: address: '127.0.0.1', Aug 17 07:03:18 hipi volumio[1181]: port: 9879, Aug 17 07:03:18 hipi volumio[1181]: response: undefined Aug 17 07:03:18 hipi volumio[1181]: } Aug 17 07:03:18 hipi volumio[1181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 07:03:20 hipi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Aug 17 07:03:20 hipi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:03:20 hipi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 17 07:03:20 hipi go-librespot[2280]: go-librespot daemon starting... Aug 17 07:03:20 hipi go-librespot[2281]: time="2026-08-17T07:03:20-04:00" level=info msg="running go-librespot 0.7.1" Aug 17 07:03:20 hipi go-librespot[2281]: time="2026-08-17T07:03:20-04:00" level=debug msg="app state loaded" Aug 17 07:03:20 hipi go-librespot[2281]: time="2026-08-17T07:03:20-04:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 17 07:03:21 hipi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Aug 17 07:03:21 hipi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:03:21 hipi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 17 07:03:21 hipi upmpdcli[2289]: Could not open config: /tmp/upmpdcli.conf Aug 17 07:03:21 hipi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 17 07:03:21 hipi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 17 07:03:23 hipi sudo[2292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-17 07:02' Aug 17 07:03:23 hipi sudo[2292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"