Jun 23 11:35:00 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:00 volumiorf go-librespot[2243]: go-librespot daemon starting... Jun 23 11:35:00 volumiorf go-librespot[2244]: time="2026-06-23T11:35:00+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:00 volumiorf go-librespot[2244]: time="2026-06-23T11:35:00+02:00" level=debug msg="app state loaded" Jun 23 11:35:00 volumiorf go-librespot[2244]: time="2026-06-23T11:35:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:00 volumiorf go-librespot[2244]: time="2026-06-23T11:35:00+02: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" Jun 23 11:35:00 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:00 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:01 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:01 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:03 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Jun 23 11:35:03 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:03 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:03 volumiorf go-librespot[2266]: go-librespot daemon starting... Jun 23 11:35:03 volumiorf go-librespot[2267]: time="2026-06-23T11:35:03+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:03 volumiorf go-librespot[2267]: time="2026-06-23T11:35:03+02:00" level=debug msg="app state loaded" Jun 23 11:35:03 volumiorf go-librespot[2267]: time="2026-06-23T11:35:03+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:03 volumiorf go-librespot[2267]: time="2026-06-23T11:35:03+02: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" Jun 23 11:35:03 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:03 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:04 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:04 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:06 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Jun 23 11:35:06 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:06 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:06 volumiorf go-librespot[2275]: go-librespot daemon starting... Jun 23 11:35:06 volumiorf go-librespot[2276]: time="2026-06-23T11:35:06+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:06 volumiorf go-librespot[2276]: time="2026-06-23T11:35:06+02:00" level=debug msg="app state loaded" Jun 23 11:35:06 volumiorf go-librespot[2276]: time="2026-06-23T11:35:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:06 volumiorf go-librespot[2276]: time="2026-06-23T11:35:06+02: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" Jun 23 11:35:06 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:06 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:07 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:07 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:07 volumiorf ifplugd(eth0)[1078]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Jun 23 11:35:07 volumiorf dhcpcd[2294]: dhcpcd not running Jun 23 11:35:07 volumiorf ifplugd(eth0)[1078]: client: dhcpcd not running Jun 23 11:35:07 volumiorf ifplugd(eth0)[1078]: Program executed successfully. Jun 23 11:35:07 volumiorf kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Jun 23 11:35:07 volumiorf kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jun 23 11:35:08 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:08 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:08 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:08 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: === SNM TRANSITION === Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Previous ethernet state: connected Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: New ethernet state: disconnected Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Single Network Mode: enabled Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: First start: no Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Action: Reconnect WiFi Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: === END TRANSITION === Jun 23 11:35:08 volumiorf sudo[2309]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 23 11:35:08 volumiorf sudo[2309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 23 11:35:08 volumiorf sudo[2309]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: SNM: Ethernet disconnected, reconnecting WiFi Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: SNM: Ethernet disconnected, reconnecting WiFi Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: reconnectWiFi: Reconnect command failed: Error: Command failed: /sbin/wpa_cli -i wlan0 reconnect Jun 23 11:35:08 volumiorf wireless.js[747]: Failed to connect to non-global ctrl_ifname: wlan0 error: No such file or directory Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: reconnectWiFi: Falling back to full wireless flow restart Jun 23 11:35:08 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Jun 23 11:35:09 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:09.088+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:09 volumiorf sudo[2324]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 23 11:35:09 volumiorf systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:09 volumiorf sudo[2324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:09 volumiorf systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 23 11:35:09 volumiorf sudo[2324]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:09 volumiorf sudo[2326]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 23 11:35:09 volumiorf sudo[2326]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:09 volumiorf systemd[1]: nmbd.service: start operation timed out. Terminating. Jun 23 11:35:09 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Jun 23 11:35:09 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:09 volumiorf sudo[2326]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:09 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Cleaning previous... Jun 23 11:35:09 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:09 volumiorf systemd[1]: nmbd.service: Failed with result 'timeout'. Jun 23 11:35:09 volumiorf go-librespot[2328]: go-librespot daemon starting... Jun 23 11:35:09 volumiorf systemd[1]: Failed to start nmbd.service - Samba NMB Daemon. Jun 23 11:35:09 volumiorf systemd[1]: Starting winbind.service - Samba Winbind Daemon... Jun 23 11:35:09 volumiorf sudo[2330]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 23 11:35:09 volumiorf sudo[2330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:09 volumiorf sudo[2330]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:09 volumiorf kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 23 11:35:09 volumiorf go-librespot[2331]: time="2026-06-23T11:35:09+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:09 volumiorf go-librespot[2331]: time="2026-06-23T11:35:09+02:00" level=debug msg="app state loaded" Jun 23 11:35:09 volumiorf go-librespot[2331]: time="2026-06-23T11:35:09+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:09 volumiorf go-librespot[2331]: time="2026-06-23T11:35:09+02: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" Jun 23 11:35:09 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:09 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:09 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Jun 23 11:35:09 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 0ms Jun 23 11:35:09 volumiorf wireless.js[747]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: dc:a6:32:34:b1:ae) Jun 23 11:35:10 volumiorf sudo[2348]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 23 11:35:10 volumiorf sudo[2348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 23 11:35:10 volumiorf sudo[2348]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:10 volumiorf sudo[2356]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 23 11:35:10 volumiorf sudo[2356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 23 11:35:10 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:10 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:10 volumiorf winbindd[2347]: [2026/06/23 11:35:10.227352, 0] ../../source3/winbindd/winbindd.c:1440(main) Jun 23 11:35:10 volumiorf winbindd[2347]: winbindd version 4.17.8-Raspbian started. Jun 23 11:35:10 volumiorf winbindd[2347]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jun 23 11:35:10 volumiorf winbindd[2347]: [2026/06/23 11:35:10.243486, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Jun 23 11:35:10 volumiorf winbindd[2347]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 23 11:35:10 volumiorf systemd[1]: Started winbind.service - Samba Winbind Daemon. Jun 23 11:35:10 volumiorf systemd[1]: Starting smbd.service - Samba SMB Daemon... Jun 23 11:35:10 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:10 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:10 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:10 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:10 volumiorf smbd[2376]: [2026/06/23 11:35:10.754292, 0] ../../source3/smbd/server.c:1741(main) Jun 23 11:35:10 volumiorf smbd[2376]: smbd version 4.17.8-Raspbian started. Jun 23 11:35:10 volumiorf smbd[2376]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jun 23 11:35:11 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:11.221+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:11 volumiorf systemd[1]: Started smbd.service - Samba SMB Daemon. Jun 23 11:35:11 volumiorf systemd[1]: Reached target multi-user.target - Multi-User System. Jun 23 11:35:11 volumiorf systemd[1]: Reached target graphical.target - Graphical Interface. Jun 23 11:35:11 volumiorf systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Jun 23 11:35:11 volumiorf systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jun 23 11:35:11 volumiorf systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Jun 23 11:35:11 volumiorf systemd[1]: Startup finished in 13.496s (kernel) + 1min 38.949s (userspace) = 1min 52.446s. Jun 23 11:35:12 volumiorf sudo[2356]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:12 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Regdomain already correct: DE Jun 23 11:35:12 volumiorf wireless.js[747]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot Jun 23 11:35:12 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Jun 23 11:35:12 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms Jun 23 11:35:12 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Jun 23 11:35:12 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:12 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:12 volumiorf go-librespot[2405]: go-librespot daemon starting... Jun 23 11:35:13 volumiorf go-librespot[2406]: time="2026-06-23T11:35:13+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:13 volumiorf go-librespot[2406]: time="2026-06-23T11:35:13+02:00" level=debug msg="app state loaded" Jun 23 11:35:13 volumiorf go-librespot[2406]: time="2026-06-23T11:35:13+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:13 volumiorf sudo[2413]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 23 11:35:13 volumiorf sudo[2413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:13 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:13 volumiorf go-librespot[2406]: time="2026-06-23T11:35:13+02: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" Jun 23 11:35:13 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:13 volumiorf sudo[2413]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:13 volumiorf sudo[2417]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 23 11:35:13 volumiorf sudo[2417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:13 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:13 volumiorf sudo[2417]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:13 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Hotspot is disabled, not starting it Jun 23 11:35:13 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:13 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:13 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:13 volumiorf kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:13 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:13 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:13 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Notified systemd about wireless ready Jun 23 11:35:14 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:14 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:14 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:14 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:15 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:15.485+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:16 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Jun 23 11:35:16 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:16 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:16 volumiorf go-librespot[2422]: go-librespot daemon starting... Jun 23 11:35:16 volumiorf go-librespot[2423]: time="2026-06-23T11:35:16+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:16 volumiorf go-librespot[2423]: time="2026-06-23T11:35:16+02:00" level=debug msg="app state loaded" Jun 23 11:35:16 volumiorf go-librespot[2423]: time="2026-06-23T11:35:16+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:16 volumiorf go-librespot[2423]: time="2026-06-23T11:35:16+02: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" Jun 23 11:35:16 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:16 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:16 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:16 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:19 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Jun 23 11:35:19 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:19 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:19 volumiorf go-librespot[2431]: go-librespot daemon starting... Jun 23 11:35:19 volumiorf go-librespot[2432]: time="2026-06-23T11:35:19+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:19 volumiorf go-librespot[2432]: time="2026-06-23T11:35:19+02:00" level=debug msg="app state loaded" Jun 23 11:35:19 volumiorf go-librespot[2432]: time="2026-06-23T11:35:19+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:19 volumiorf go-librespot[2432]: time="2026-06-23T11:35:19+02: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" Jun 23 11:35:19 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:19 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:19 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:19 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:22 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:22 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Jun 23 11:35:22 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:22 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:22 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:22 volumiorf go-librespot[2444]: go-librespot daemon starting... Jun 23 11:35:22 volumiorf go-librespot[2449]: time="2026-06-23T11:35:22+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:22 volumiorf go-librespot[2449]: time="2026-06-23T11:35:22+02:00" level=debug msg="app state loaded" Jun 23 11:35:22 volumiorf go-librespot[2449]: time="2026-06-23T11:35:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:22 volumiorf go-librespot[2449]: time="2026-06-23T11:35:22+02: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" Jun 23 11:35:22 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:22 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:24 volumiorf systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Jun 23 11:35:24 volumiorf systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 23 11:35:24 volumiorf systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 23 11:35:25 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:25 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:25 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Jun 23 11:35:25 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:26 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:26 volumiorf go-librespot[2473]: go-librespot daemon starting... Jun 23 11:35:26 volumiorf go-librespot[2474]: time="2026-06-23T11:35:26+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:26 volumiorf go-librespot[2474]: time="2026-06-23T11:35:26+02:00" level=debug msg="app state loaded" Jun 23 11:35:26 volumiorf go-librespot[2474]: time="2026-06-23T11:35:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:26 volumiorf go-librespot[2474]: time="2026-06-23T11:35:26+02: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" Jun 23 11:35:26 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:26 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:28 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:28 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:29 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Jun 23 11:35:29 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:29 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:29 volumiorf go-librespot[2482]: go-librespot daemon starting... Jun 23 11:35:29 volumiorf go-librespot[2483]: time="2026-06-23T11:35:29+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:29 volumiorf go-librespot[2483]: time="2026-06-23T11:35:29+02:00" level=debug msg="app state loaded" Jun 23 11:35:29 volumiorf go-librespot[2483]: time="2026-06-23T11:35:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:29 volumiorf go-librespot[2483]: time="2026-06-23T11:35:29+02: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" Jun 23 11:35:29 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:29 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:31 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:31 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:32 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Jun 23 11:35:32 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:32 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:32 volumiorf go-librespot[2491]: go-librespot daemon starting... Jun 23 11:35:32 volumiorf go-librespot[2492]: time="2026-06-23T11:35:32+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:32 volumiorf go-librespot[2492]: time="2026-06-23T11:35:32+02:00" level=debug msg="app state loaded" Jun 23 11:35:32 volumiorf go-librespot[2492]: time="2026-06-23T11:35:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:32 volumiorf go-librespot[2492]: time="2026-06-23T11:35:32+02: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" Jun 23 11:35:32 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:32 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:34 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:34 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:35 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Jun 23 11:35:35 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:35 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:35 volumiorf go-librespot[2514]: go-librespot daemon starting... Jun 23 11:35:35 volumiorf go-librespot[2515]: time="2026-06-23T11:35:35+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:35 volumiorf go-librespot[2515]: time="2026-06-23T11:35:35+02:00" level=debug msg="app state loaded" Jun 23 11:35:35 volumiorf go-librespot[2515]: time="2026-06-23T11:35:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:35 volumiorf go-librespot[2515]: time="2026-06-23T11:35:35+02: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" Jun 23 11:35:35 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:35 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:37 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:37 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:38 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Jun 23 11:35:38 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:39 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:39 volumiorf go-librespot[2523]: go-librespot daemon starting... Jun 23 11:35:39 volumiorf go-librespot[2524]: time="2026-06-23T11:35:39+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:39 volumiorf go-librespot[2524]: time="2026-06-23T11:35:39+02:00" level=debug msg="app state loaded" Jun 23 11:35:39 volumiorf go-librespot[2524]: time="2026-06-23T11:35:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:39 volumiorf go-librespot[2524]: time="2026-06-23T11:35:39+02: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" Jun 23 11:35:39 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:39 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:40 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:40 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:42 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Jun 23 11:35:42 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:42 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:42 volumiorf go-librespot[2532]: go-librespot daemon starting... Jun 23 11:35:42 volumiorf go-librespot[2533]: time="2026-06-23T11:35:42+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:42 volumiorf go-librespot[2533]: time="2026-06-23T11:35:42+02:00" level=debug msg="app state loaded" Jun 23 11:35:42 volumiorf go-librespot[2533]: time="2026-06-23T11:35:42+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:42 volumiorf go-librespot[2533]: time="2026-06-23T11:35:42+02: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" Jun 23 11:35:42 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:42 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:43 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:43 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:45 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Jun 23 11:35:45 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:45 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:45 volumiorf go-librespot[2556]: go-librespot daemon starting... Jun 23 11:35:45 volumiorf go-librespot[2557]: time="2026-06-23T11:35:45+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:45 volumiorf go-librespot[2557]: time="2026-06-23T11:35:45+02:00" level=debug msg="app state loaded" Jun 23 11:35:45 volumiorf go-librespot[2557]: time="2026-06-23T11:35:45+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:45 volumiorf go-librespot[2557]: time="2026-06-23T11:35:45+02: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" Jun 23 11:35:45 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:45 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:46 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:46 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:48 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Jun 23 11:35:48 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:48 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:48 volumiorf go-librespot[2565]: go-librespot daemon starting... Jun 23 11:35:48 volumiorf go-librespot[2566]: time="2026-06-23T11:35:48+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:48 volumiorf go-librespot[2566]: time="2026-06-23T11:35:48+02:00" level=debug msg="app state loaded" Jun 23 11:35:48 volumiorf go-librespot[2566]: time="2026-06-23T11:35:48+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:48 volumiorf go-librespot[2566]: time="2026-06-23T11:35:48+02: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" Jun 23 11:35:48 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:48 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:49 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:49 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:50 volumiorf dhcpcd[777]: eth0: carrier acquired Jun 23 11:35:50 volumiorf kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Jun 23 11:35:50 volumiorf dhcpcd[777]: eth0: IAID 32:34:b1:ab Jun 23 11:35:50 volumiorf ifplugd(eth0)[1078]: Link beat detected. Jun 23 11:35:50 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:50 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:50 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:50 volumiorf ifplugd(eth0)[1078]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:50 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:51 volumiorf dhcpcd[777]: ps_ctl_dispatch: cannot handle another client Jun 23 11:35:51 volumiorf ifplugd(eth0)[1078]: client: sending commands to dhcpcd process Jun 23 11:35:51 volumiorf dhcpcd[777]: control_free: No such file or directory Jun 23 11:35:51 volumiorf dhcpcd[777]: eth0: soliciting a DHCP lease Jun 23 11:35:51 volumiorf dhcpcd[777]: eth0: soliciting an IPv6 router Jun 23 11:35:51 volumiorf ifplugd(eth0)[1078]: Program executed successfully. Jun 23 11:35:51 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:51.755+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: === SNM TRANSITION === Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: New ethernet state: connected Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Single Network Mode: enabled Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: First start: no Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: === END TRANSITION === Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Jun 23 11:35:51 volumiorf sudo[2627]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Jun 23 11:35:51 volumiorf sudo[2627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:51 volumiorf dhcpcd[2628]: dhcpcd not running Jun 23 11:35:51 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Jun 23 11:35:51 volumiorf sudo[2627]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:51 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:51 volumiorf wireless.js[747]: dhcpcd not running Jun 23 11:35:51 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Jun 23 11:35:52 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:52 volumiorf go-librespot[2629]: go-librespot daemon starting... Jun 23 11:35:52 volumiorf go-librespot[2632]: time="2026-06-23T11:35:52+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:52 volumiorf go-librespot[2632]: time="2026-06-23T11:35:52+02:00" level=debug msg="app state loaded" Jun 23 11:35:52 volumiorf go-librespot[2632]: time="2026-06-23T11:35:52+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:52 volumiorf go-librespot[2632]: time="2026-06-23T11:35:52+02: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" Jun 23 11:35:52 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:52 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:52 volumiorf sudo[2645]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 23 11:35:52 volumiorf sudo[2645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:52 volumiorf sudo[2645]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:52 volumiorf sudo[2647]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 23 11:35:52 volumiorf sudo[2647]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:52 volumiorf sudo[2647]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:52 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Cleaning previous... Jun 23 11:35:53 volumiorf sudo[2650]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 23 11:35:53 volumiorf sudo[2650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 23 11:35:53 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:53 volumiorf sudo[2650]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:53 volumiorf kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 23 11:35:53 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:53 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Jun 23 11:35:53 volumiorf wireless.js[747]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms Jun 23 11:35:53 volumiorf wireless.js[747]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: dc:a6:32:34:b1:ae) Jun 23 11:35:53 volumiorf sudo[2657]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 23 11:35:53 volumiorf sudo[2657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 23 11:35:53 volumiorf sudo[2657]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:53 volumiorf sudo[2665]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 23 11:35:53 volumiorf sudo[2665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 23 11:35:53 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:53 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:53 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:53 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:54 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:54.391+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:55 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Jun 23 11:35:55 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:55 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:55 volumiorf go-librespot[2683]: go-librespot daemon starting... Jun 23 11:35:55 volumiorf go-librespot[2684]: time="2026-06-23T11:35:55+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:55 volumiorf go-librespot[2684]: time="2026-06-23T11:35:55+02:00" level=debug msg="app state loaded" Jun 23 11:35:55 volumiorf go-librespot[2684]: time="2026-06-23T11:35:55+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:55 volumiorf go-librespot[2684]: time="2026-06-23T11:35:55+02: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" Jun 23 11:35:55 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:55 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:55 volumiorf sudo[2665]: pam_unix(sudo:session): session closed for user root Jun 23 11:35:55 volumiorf wireless.js[747]: WIRELESS.JS - INFO: Regdomain already correct: DE Jun 23 11:35:56 volumiorf dhcpcd[777]: eth0: probing for an IPv4LL address Jun 23 11:35:56 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:56 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:35:56 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:35:56 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:35:56 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:35:56 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:35:57 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:35:57.179+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:35:58 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Jun 23 11:35:58 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:58 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:35:58 volumiorf go-librespot[2693]: go-librespot daemon starting... Jun 23 11:35:58 volumiorf go-librespot[2694]: time="2026-06-23T11:35:58+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:35:58 volumiorf go-librespot[2694]: time="2026-06-23T11:35:58+02:00" level=debug msg="app state loaded" Jun 23 11:35:58 volumiorf go-librespot[2694]: time="2026-06-23T11:35:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:35:58 volumiorf go-librespot[2694]: time="2026-06-23T11:35:58+02: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" Jun 23 11:35:58 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:35:58 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:35:59 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:35:59 volumiorf volumio[1215]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 11:36:00 volumiorf dhcpcd[777]: eth0: using IPv4LL address 169.254.71.245 Jun 23 11:36:00 volumiorf avahi-daemon[715]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.71.245. Jun 23 11:36:00 volumiorf avahi-daemon[715]: New relevant interface eth0.IPv4 for mDNS. Jun 23 11:36:00 volumiorf avahi-daemon[715]: Registering new address record for 169.254.71.245 on eth0.IPv4. Jun 23 11:36:00 volumiorf dhcpcd[777]: eth0: adding route to 169.254.0.0/16 Jun 23 11:36:00 volumiorf dhcpcd[777]: eth0: adding default route Jun 23 11:36:00 volumiorf systemd[1]: welcome.service: Deactivated successfully. Jun 23 11:36:00 volumiorf systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 23 11:36:00 volumiorf systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 23 11:36:00 volumiorf systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 23 11:36:00 volumiorf welcome[2711]: Resolved ip:[1] 169.254.71.245 Jun 23 11:36:00 volumiorf systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 23 11:36:00 volumiorf systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jun 23 11:36:00 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:36:00 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:36:00 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:36:00 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:36:01 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:36:01.549+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:36:01 volumiorf ntpd[1066]: IO: Listen normally on 3 eth0 169.254.71.245:123 Jun 23 11:36:01 volumiorf ntpd[1066]: IO: new interface(s) found: waking up resolver Jun 23 11:36:01 volumiorf ntpd[1066]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 23 11:36:01 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34. Jun 23 11:36:01 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:36:01 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:36:01 volumiorf go-librespot[2718]: go-librespot daemon starting... Jun 23 11:36:01 volumiorf go-librespot[2719]: time="2026-06-23T11:36:01+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:36:01 volumiorf go-librespot[2719]: time="2026-06-23T11:36:01+02:00" level=debug msg="app state loaded" Jun 23 11:36:01 volumiorf go-librespot[2719]: time="2026-06-23T11:36:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:36:02 volumiorf volumio[1215]: info: Initializing connection to go-librespot Websocket Jun 23 11:36:02 volumiorf go-librespot[2719]: time="2026-06-23T11:36:02+02:00" level=debug msg="new websocket client" Jun 23 11:36:02 volumiorf volumio[1215]: info: Connection to go-librespot Websocket established Jun 23 11:36:02 volumiorf dhcpcd[777]: eth0: offered 192.168.75.238 from 192.168.75.1 Jun 23 11:36:02 volumiorf dhcpcd[777]: eth0: probing address 192.168.75.238/22 Jun 23 11:36:04 volumiorf volumio[1215]: info: Volumio Network Manager: Network status updated: 1 Jun 23 11:36:05 volumiorf volumio[1215]: info: Getting Spotify volume Jun 23 11:36:07 volumiorf dhcpcd[777]: eth0: leased 192.168.75.238 for 300 seconds Jun 23 11:36:07 volumiorf avahi-daemon[715]: Registering new address record for 192.168.75.238 on eth0.IPv4. Jun 23 11:36:07 volumiorf dhcpcd[777]: eth0: adding route to 192.168.72.0/22 Jun 23 11:36:07 volumiorf dhcpcd[777]: eth0: changing default route via 192.168.75.1 Jun 23 11:36:07 volumiorf systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jun 23 11:36:07 volumiorf systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jun 23 11:36:07 volumiorf systemd[1]: welcome.service: Deactivated successfully. Jun 23 11:36:07 volumiorf systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 23 11:36:07 volumiorf systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 23 11:36:07 volumiorf systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 23 11:36:07 volumiorf welcome[2760]: Resolved ip:[2] 169.254.71.245 192.168.75.238 Jun 23 11:36:07 volumiorf avahi-daemon[715]: Withdrawing address record for 169.254.71.245 on eth0. Jun 23 11:36:07 volumiorf avahi-daemon[715]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.71.245. Jun 23 11:36:07 volumiorf avahi-daemon[715]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.75.238. Jun 23 11:36:07 volumiorf dhcpcd[777]: eth0: deleting route to 169.254.0.0/16 Jun 23 11:36:07 volumiorf systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 23 11:36:07 volumiorf systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jun 23 11:36:07 volumiorf systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jun 23 11:36:07 volumiorf systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jun 23 11:36:07 volumiorf systemd[1]: welcome.service: Deactivated successfully. Jun 23 11:36:07 volumiorf systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 23 11:36:07 volumiorf systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 23 11:36:07 volumiorf systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 23 11:36:07 volumiorf welcome[2794]: Resolved ip:[1] 192.168.75.238 Jun 23 11:36:07 volumiorf systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 23 11:36:07 volumiorf systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jun 23 11:36:07 volumiorf volumio[1215]: info: Received Get System Info Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 11:36:07 volumiorf volumio[1215]: info: Discovery: Getting this device information Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:36:07 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 23 11:36:07 volumiorf volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 23 11:36:08 volumiorf ntpd[1066]: IO: Listen normally on 4 eth0 192.168.75.238:123 Jun 23 11:36:08 volumiorf ntpd[1066]: IO: Deleting interface #3 eth0, 169.254.71.245#123, interface stats: received=0, sent=0, dropped=0, active_time=7 secs Jun 23 11:36:08 volumiorf ntpd[1066]: IO: new interface(s) found: waking up resolver Jun 23 11:36:08 volumiorf volumio5-onboarding[1387]: time=2026-06-23T11:36:08.699+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 23 11:36:08 volumiorf upmpdcli[2799]: writing RSA key Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: Pool taking: 193.138.81.81 Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: Pool taking: 193.158.22.13 Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: Pool taking: 85.215.64.237 Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: Pool taking: 217.144.138.234 Jun 23 11:36:10 volumiorf ntpd[1066]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Jun 23 11:36:10 volumiorf volumio[1215]: info: Discovery: this is already registered, 39530b4e-efcc-42b3-861e-fe77f090e174 Jun 23 11:36:10 volumiorf volumio[1215]: info: Discovery: Found device Volumiorf Jun 23 11:36:10 volumiorf volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 23 11:36:10 volumiorf volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 23 11:36:10 volumiorf volumio[1215]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 23 11:36:10 volumiorf go-librespot[2719]: time="2026-06-23T11:36:10+02: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\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-06-23T11:36:10+02:00 is before 2026-07-09T00:00:00Z" Jun 23 11:36:10 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:36:10 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:36:11 volumiorf volumio[1215]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 11:36:11 volumiorf volumio[1215]: Error: socket hang up Jun 23 11:36:11 volumiorf volumio[1215]: at connResetException (node:internal/errors:720:14) Jun 23 11:36:11 volumiorf volumio[1215]: at Socket.socketOnEnd (node:_http_client:519:23) Jun 23 11:36:11 volumiorf volumio[1215]: at Socket.emit (node:events:526:35) Jun 23 11:36:11 volumiorf volumio[1215]: at endReadableNT (node:internal/streams/readable:1376:12) Jun 23 11:36:11 volumiorf volumio[1215]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Jun 23 11:36:11 volumiorf volumio[1215]: code: 'ECONNRESET', Jun 23 11:36:11 volumiorf volumio[1215]: response: undefined Jun 23 11:36:11 volumiorf volumio[1215]: } Jun 23 11:36:11 volumiorf volumio[1215]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 134.60.1.27 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 5.189.151.39 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 139.144.71.56 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 5.75.251.87 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 2a01:239:236:1800::1 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 2a01:4f8:c2c:477d::2 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 2a02:8106:21:9400::2 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: Pool taking: 2a01:4f8:1c17:570d::1 Jun 23 11:36:11 volumiorf ntpd[1066]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: Pool taking: 193.32.222.35 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: Pool taking: 78.47.184.132 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: Pool taking: 139.162.156.95 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: Pool taking: 94.103.173.120 Jun 23 11:36:12 volumiorf ntpd[1066]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: Pool taking: 93.241.86.156 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: Pool taking: 85.215.189.120 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: Pool taking: 217.160.19.219 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: Pool taking: 172.104.154.182 Jun 23 11:36:13 volumiorf ntpd[1066]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Jun 23 11:36:13 volumiorf systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35. Jun 23 11:36:13 volumiorf systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:36:14 volumiorf systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 23 11:36:14 volumiorf go-librespot[2816]: go-librespot daemon starting... Jun 23 11:36:14 volumiorf go-librespot[2817]: time="2026-06-23T11:36:14+02:00" level=info msg="running go-librespot 0.6.2" Jun 23 11:36:14 volumiorf go-librespot[2817]: time="2026-06-23T11:36:14+02:00" level=debug msg="app state loaded" Jun 23 11:36:14 volumiorf go-librespot[2817]: time="2026-06-23T11:36:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 23 11:36:14 volumiorf go-librespot[2817]: time="2026-06-23T11:36:14+02: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\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-06-23T11:36:14+02:00 is before 2026-07-09T00:00:00Z" Jun 23 11:36:14 volumiorf systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 11:36:14 volumiorf systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 11:36:15 volumiorf sudo[2842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-23 11:35' Jun 23 11:36:15 volumiorf sudo[2842]: 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"