Jan 25 17:37:00 volumio ntpd[968]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 25 17:37:00 volumio ntpd[968]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jan 25 17:37:00 volumio ntpd[968]: DNS: dns_check: DNS error: -11, System error Jan 25 17:37:00 volumio ntpd[968]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Jan 25 17:37:01 volumio mpd[7595]: 2026-01-25T17:37:01 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 25 17:37:01 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 25 17:37:01 volumio sudo[7558]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:01 volumio sudo[7568]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:01 volumio volumio[7357]: info: Completed starting Core Plugins Jan 25 17:37:01 volumio volumio[7357]: info: ------------------------------------------- Jan 25 17:37:01 volumio volumio[7357]: info: ----- MyVolumio plugins startup ---- Jan 25 17:37:01 volumio volumio[7357]: info: ------------------------------------------- Jan 25 17:37:01 volumio volumio[7357]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 25 17:37:01 volumio volumio[7357]: error: MPD error: The expression evaluated to a falsy value: Jan 25 17:37:01 volumio volumio[7357]: assert.ok(self.idling) Jan 25 17:37:01 volumio volumio[7357]: error: The expression evaluated to a falsy value: Jan 25 17:37:01 volumio volumio[7357]: assert.ok(self.idling) Jan 25 17:37:01 volumio volumio[7357]: info: Volumio Network Manager: Network status updated: 0 Jan 25 17:37:01 volumio volumio[7357]: info: MPD running with PID7595 Jan 25 17:37:01 volumio volumio[7357]: ,establishing connection Jan 25 17:37:01 volumio volumio[7357]: error: updateQueue error: null Jan 25 17:37:01 volumio volumio[7357]: error: updateQueue error: null Jan 25 17:37:02 volumio sudo[7690]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 17:37:02 volumio sudo[7690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:02 volumio sudo[7692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 17:37:02 volumio sudo[7690]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:02 volumio sudo[7692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:02 volumio sudo[7692]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:02 volumio sudo[7694]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 25 17:37:02 volumio sudo[7694]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:02 volumio sudo[7694]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:02 volumio volumio[7357]: info: Upmpdcli Daemon Started Jan 25 17:37:02 volumio volumio[7357]: info: go-librespot daemon successfully initialized Jan 25 17:37:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Jan 25 17:37:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:02 volumio go-librespot[7698]: go-librespot daemon starting... Jan 25 17:37:02 volumio go-librespot[7699]: time="2026-01-25T17:37:02+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:02 volumio go-librespot[7699]: time="2026-01-25T17:37:02+01:00" level=debug msg="app state loaded" Jan 25 17:37:02 volumio go-librespot[7699]: time="2026-01-25T17:37:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:02 volumio go-librespot[7699]: time="2026-01-25T17:37:02+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:03 volumio ifplugd(eth0)[993]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Jan 25 17:37:03 volumio ifplugd(eth0)[993]: client: dhcpcd not running Jan 25 17:37:03 volumio dhcpcd[7717]: dhcpcd not running Jan 25 17:37:03 volumio wireless.js[630]: WIRELESS.JS: Wired network status changed to: ---disconnected--- Jan 25 17:37:03 volumio wireless.js[630]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 25 17:37:03 volumio wireless.js[630]: WIRELESS.JS: Cleaning previous... Jan 25 17:37:03 volumio ifplugd(eth0)[993]: Program executed successfully. Jan 25 17:37:03 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Jan 25 17:37:03 volumio kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Jan 25 17:37:03 volumio sudo[7734]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 25 17:37:03 volumio sudo[7734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:03 volumio sudo[7734]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:03 volumio sudo[7736]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 25 17:37:03 volumio sudo[7736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:04 volumio volumio-remote-updater[628]: [2026-01-25 17:37:04] [connect] Successful connection Jan 25 17:37:04 volumio sudo[7736]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio volumio-remote-updater[628]: [2026-01-25 17:37:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1769359023 101 Jan 25 17:37:04 volumio volumio[7357]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Jan 25 17:37:04 volumio wireless.js[630]: WIRELESS.JS: Stopped aP Jan 25 17:37:04 volumio sudo[7744]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 17:37:04 volumio sudo[7744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio sudo[7744]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 17:37:04 volumio sudo[7746]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 25 17:37:04 volumio sudo[7746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio sudo[7746]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio sudo[7754]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 17:37:04 volumio sudo[7754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio sudo[7754]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio sudo[7756]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 25 17:37:04 volumio sudo[7756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio sudo[7761]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 25 17:37:04 volumio sudo[7761]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio sudo[7763]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 25 17:37:04 volumio sudo[7763]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:04 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 25 17:37:04 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 25 17:37:04 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 25 17:37:04 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 25 17:37:04 volumio sudo[7761]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio sudo[7763]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:04 volumio mpd_monitor.sh[7766]: MPD Monitor Service: Starting MPD Monitor Service Jan 25 17:37:04 volumio volumio[7357]: info: Successfully started MPD Monitor Jan 25 17:37:04 volumio volumio[7357]: info: Successfully started MPD Monitor Jan 25 17:37:05 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:05 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Jan 25 17:37:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:05 volumio go-librespot[7770]: go-librespot daemon starting... Jan 25 17:37:05 volumio go-librespot[7771]: time="2026-01-25T17:37:05+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:05 volumio go-librespot[7771]: time="2026-01-25T17:37:05+01:00" level=debug msg="app state loaded" Jan 25 17:37:05 volumio go-librespot[7771]: time="2026-01-25T17:37:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:05 volumio go-librespot[7771]: time="2026-01-25T17:37:05+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:06 volumio volumio[7357]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 25 17:37:07 volumio sudo[7756]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:07 volumio wireless.js[630]: WIRELESS.JS: Start wireless flow Jan 25 17:37:07 volumio wireless.js[630]: WIRELESS.JS: Stopped hotspot (if there).. Jan 25 17:37:07 volumio sudo[7783]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 25 17:37:07 volumio sudo[7783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:07 volumio sudo[7783]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:07 volumio sudo[7785]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 25 17:37:07 volumio sudo[7785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:07 volumio sudo[7785]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:07 volumio wireless.js[630]: WIRELESS.JS: DHCP IP fallback Jan 25 17:37:07 volumio wireless.js[630]: WIRELESS.JS: Start ap Jan 25 17:37:07 volumio wpa_supplicant[7790]: Successfully initialized wpa_supplicant Jan 25 17:37:07 volumio sudo[7791]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 25 17:37:07 volumio sudo[7791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:07 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 17:37:07 volumio dhcpcd[696]: ps_ctl_dispatch: cannot handle another client Jan 25 17:37:07 volumio dhcpcd[696]: control_free: No such file or directory Jan 25 17:37:07 volumio sudo[7791]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:07 volumio wpa_supplicant[7790]: nl80211: kernel reports: Registration to specific type not supported Jan 25 17:37:08 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:08 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:08 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:08 volumio sudo[7798]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:08 volumio sudo[7798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:08 volumio sudo[7798]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Jan 25 17:37:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:09 volumio volumio[7357]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=3a087d4da0701b3149d3d71dfb9d4b0c" http://updates.volumio.org/downloader-v1/track-device Jan 25 17:37:09 volumio volumio[7357]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 17:37:09 volumio volumio[7357]: Dload Upload Total Spent Left Speed Jan 25 17:37:09 volumio volumio[7357]: [132B blob data] Jan 25 17:37:09 volumio volumio[7357]: retrying in 5 seconds, trial 0 Jan 25 17:37:09 volumio volumio[7357]: info: Volumio Calling Home Jan 25 17:37:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:09 volumio go-librespot[7800]: go-librespot daemon starting... Jan 25 17:37:09 volumio go-librespot[7804]: time="2026-01-25T17:37:09+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:09 volumio go-librespot[7804]: time="2026-01-25T17:37:09+01:00" level=debug msg="app state loaded" Jan 25 17:37:09 volumio go-librespot[7804]: time="2026-01-25T17:37:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:09 volumio go-librespot[7804]: time="2026-01-25T17:37:09+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:09 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:09 volumio sudo[7814]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:09 volumio sudo[7814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:09 volumio sudo[7814]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:10 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:10 volumio sudo[7819]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:10 volumio sudo[7819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:10 volumio sudo[7819]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:11 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:11 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:11 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:11 volumio sudo[7823]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:11 volumio sudo[7823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:11 volumio sudo[7823]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Jan 25 17:37:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:12 volumio go-librespot[7839]: go-librespot daemon starting... Jan 25 17:37:12 volumio go-librespot[7840]: time="2026-01-25T17:37:12+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:12 volumio go-librespot[7840]: time="2026-01-25T17:37:12+01:00" level=debug msg="app state loaded" Jan 25 17:37:12 volumio go-librespot[7840]: time="2026-01-25T17:37:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:12 volumio go-librespot[7840]: time="2026-01-25T17:37:12+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:12 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:12 volumio sudo[7850]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:12 volumio sudo[7850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:12 volumio sudo[7850]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:13 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:13 volumio sudo[7854]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:13 volumio sudo[7854]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:13 volumio sudo[7854]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:14 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:14 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:14 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:14 volumio sudo[7858]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:14 volumio sudo[7858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:14 volumio sudo[7858]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Jan 25 17:37:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:15 volumio go-librespot[7860]: go-librespot daemon starting... Jan 25 17:37:15 volumio go-librespot[7861]: time="2026-01-25T17:37:15+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:15 volumio go-librespot[7861]: time="2026-01-25T17:37:15+01:00" level=debug msg="app state loaded" Jan 25 17:37:15 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:15 volumio go-librespot[7861]: time="2026-01-25T17:37:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:15 volumio go-librespot[7861]: time="2026-01-25T17:37:15+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:15 volumio sudo[7871]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:15 volumio sudo[7871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:15 volumio sudo[7871]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:16 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:16 volumio sudo[7875]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:16 volumio sudo[7875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:16 volumio sudo[7875]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:17 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:17 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:17 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:17 volumio sudo[7879]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:17 volumio sudo[7879]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:17 volumio sudo[7879]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:18 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:18 volumio sudo[7883]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:18 volumio sudo[7883]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:18 volumio sudo[7883]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Jan 25 17:37:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:18 volumio go-librespot[7885]: go-librespot daemon starting... Jan 25 17:37:18 volumio go-librespot[7886]: time="2026-01-25T17:37:18+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:18 volumio go-librespot[7886]: time="2026-01-25T17:37:18+01:00" level=debug msg="app state loaded" Jan 25 17:37:18 volumio go-librespot[7886]: time="2026-01-25T17:37:18+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:18 volumio go-librespot[7886]: time="2026-01-25T17:37:18+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:19 volumio volumio[7357]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=3a087d4da0701b3149d3d71dfb9d4b0c" http://updates.volumio.org/downloader-v1/track-device Jan 25 17:37:19 volumio volumio[7357]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 17:37:19 volumio volumio[7357]: Dload Upload Total Spent Left Speed Jan 25 17:37:19 volumio volumio[7357]: [132B blob data] Jan 25 17:37:19 volumio volumio[7357]: retrying in 5 seconds, trial 1 Jan 25 17:37:19 volumio volumio[7357]: info: Volumio Calling Home Jan 25 17:37:19 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:19 volumio sudo[7899]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:19 volumio sudo[7899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:19 volumio sudo[7899]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:20 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:20 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:20 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:20 volumio sudo[7903]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:20 volumio sudo[7903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:20 volumio sudo[7903]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:21 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:21 volumio sudo[7907]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:21 volumio sudo[7907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:21 volumio sudo[7907]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:21 volumio volumio[7357]: error: MyVolumio Plugin failed to start in a timely fashion Jan 25 17:37:21 volumio volumio[7357]: [Metrics] CommandRouter: 33s 441.69ms Jan 25 17:37:21 volumio volumio[7357]: info: CoreCommandRouter::volumiosetStartupVolume Jan 25 17:37:21 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 17:37:21 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 17:37:21 volumio volumio[7357]: info: CoreCommandRouter::Close All Modals sent Jan 25 17:37:21 volumio volumio[7357]: info: CoreCommandRouter::Close All Modals sent Jan 25 17:37:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Jan 25 17:37:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:22 volumio go-librespot[7925]: go-librespot daemon starting... Jan 25 17:37:22 volumio go-librespot[7926]: time="2026-01-25T17:37:22+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:22 volumio go-librespot[7926]: time="2026-01-25T17:37:22+01:00" level=debug msg="app state loaded" Jan 25 17:37:22 volumio go-librespot[7926]: time="2026-01-25T17:37:22+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:22 volumio go-librespot[7926]: time="2026-01-25T17:37:22+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:22 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:22 volumio sudo[7936]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:22 volumio sudo[7936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:22 volumio sudo[7936]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:22 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 25 17:37:22 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 25 17:37:22 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 25 17:37:23 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:23 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:23 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:23 volumio sudo[7943]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:23 volumio sudo[7943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:23 volumio sudo[7943]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:24 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:24 volumio sudo[7947]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:24 volumio sudo[7947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:24 volumio sudo[7947]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Jan 25 17:37:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:25 volumio go-librespot[7952]: go-librespot daemon starting... Jan 25 17:37:25 volumio go-librespot[7953]: time="2026-01-25T17:37:25+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:25 volumio go-librespot[7953]: time="2026-01-25T17:37:25+01:00" level=debug msg="app state loaded" Jan 25 17:37:25 volumio go-librespot[7953]: time="2026-01-25T17:37:25+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:25 volumio go-librespot[7953]: time="2026-01-25T17:37:25+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:25 volumio wpa_supplicant[7795]: wlan0: Failed to initiate sched scan Jan 25 17:37:25 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:25 volumio sudo[7963]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:25 volumio sudo[7963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:25 volumio sudo[7963]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:26 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:26 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:26 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:26 volumio sudo[7967]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:26 volumio sudo[7967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:26 volumio sudo[7967]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:27 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:27 volumio sudo[7971]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:27 volumio sudo[7971]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:27 volumio sudo[7971]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Jan 25 17:37:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:28 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 25 17:37:28 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 17:37:28 volumio volumio[7357]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 25 17:37:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:28 volumio go-librespot[7973]: go-librespot daemon starting... Jan 25 17:37:28 volumio go-librespot[7977]: time="2026-01-25T17:37:28+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:28 volumio go-librespot[7977]: time="2026-01-25T17:37:28+01:00" level=debug msg="app state loaded" Jan 25 17:37:28 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:28 volumio go-librespot[7977]: time="2026-01-25T17:37:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:28 volumio go-librespot[7977]: time="2026-01-25T17:37:28+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:28 volumio sudo[7986]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:28 volumio sudo[7986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:28 volumio sudo[7986]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:28 volumio volumio[7357]: info: BOOT COMPLETED Jan 25 17:37:29 volumio volumio[7357]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=3a087d4da0701b3149d3d71dfb9d4b0c" http://updates.volumio.org/downloader-v1/track-device Jan 25 17:37:29 volumio volumio[7357]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 17:37:29 volumio volumio[7357]: Dload Upload Total Spent Left Speed Jan 25 17:37:29 volumio volumio[7357]: [132B blob data] Jan 25 17:37:29 volumio volumio[7357]: retrying in 5 seconds, trial 2 Jan 25 17:37:29 volumio volumio[7357]: info: Volumio Calling Home Jan 25 17:37:29 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:29 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:29 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:29 volumio sudo[7994]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:29 volumio sudo[7994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:29 volumio sudo[7994]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.189863, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jan 25 17:37:30 volumio nmbd[1061]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.191249, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 25 17:37:30 volumio nmbd[1061]: send_netbios_packet: send_packet() to IP 169.254.255.255 port 137 failed Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.191541, 0] ../../source3/nmbd/nmbd_namequery.c:245(query_name) Jan 25 17:37:30 volumio nmbd[1061]: query_name: Failed to send packet trying to query name WORKGROUP<1d> Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.191678, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jan 25 17:37:30 volumio nmbd[1061]: Packet send failed to 192.168.211.255(137) ERRNO=Network is unreachable Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.191744, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 25 17:37:30 volumio nmbd[1061]: send_netbios_packet: send_packet() to IP 192.168.211.255 port 137 failed Jan 25 17:37:30 volumio nmbd[1061]: [2026/01/25 17:37:30.191800, 0] ../../source3/nmbd/nmbd_namequery.c:245(query_name) Jan 25 17:37:30 volumio nmbd[1061]: query_name: Failed to send packet trying to query name WORKGROUP<1d> Jan 25 17:37:30 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:30 volumio sudo[7999]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:30 volumio sudo[7999]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:30 volumio sudo[7999]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:31 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:31 volumio sudo[8003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:31 volumio sudo[8003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:31 volumio sudo[8003]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:31 volumio ifplugd(eth0)[993]: Link beat detected. Jan 25 17:37:31 volumio dhcpcd[696]: eth0: carrier acquired Jan 25 17:37:31 volumio kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jan 25 17:37:31 volumio dhcpcd[696]: eth0: IAID eb:b4:e5:27 Jan 25 17:37:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Jan 25 17:37:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:31 volumio ifplugd(eth0)[993]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jan 25 17:37:31 volumio wireless.js[630]: WIRELESS.JS: Wired network status changed to: ---connected--- Jan 25 17:37:31 volumio wireless.js[630]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 25 17:37:31 volumio wireless.js[630]: WIRELESS.JS: Cleaning previous... Jan 25 17:37:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:31 volumio go-librespot[8006]: go-librespot daemon starting... Jan 25 17:37:31 volumio dhcpcd[696]: ps_ctl_dispatch: cannot handle another client Jan 25 17:37:31 volumio dhcpcd[696]: control_free: No such file or directory Jan 25 17:37:31 volumio ifplugd(eth0)[993]: client: sending commands to dhcpcd process Jan 25 17:37:31 volumio go-librespot[8030]: time="2026-01-25T17:37:31+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:31 volumio go-librespot[8030]: time="2026-01-25T17:37:31+01:00" level=debug msg="app state loaded" Jan 25 17:37:32 volumio sudo[8059]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 25 17:37:32 volumio sudo[8059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:32 volumio go-librespot[8030]: time="2026-01-25T17:37:32+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:32 volumio go-librespot[8030]: time="2026-01-25T17:37:32+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:32 volumio sudo[8059]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:32 volumio sudo[8076]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 25 17:37:32 volumio sudo[8076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 25 17:37:32 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 25 17:37:32 volumio ifplugd(eth0)[993]: Program executed successfully. Jan 25 17:37:32 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:32 volumio sudo[8076]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:32 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:32 volumio wireless.js[630]: WIRELESS.JS: trying... Jan 25 17:37:32 volumio dhcpcd[696]: eth0: soliciting an IPv6 router Jan 25 17:37:32 volumio sudo[8091]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 17:37:32 volumio sudo[8091]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:32 volumio sudo[8091]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:32 volumio wireless.js[630]: WIRELESS.JS: Stopped aP Jan 25 17:37:32 volumio wpa_supplicant[7795]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all Jan 25 17:37:32 volumio wpa_supplicant[7795]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all Jan 25 17:37:32 volumio wpa_supplicant[7795]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 Jan 25 17:37:32 volumio sudo[8097]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 17:37:32 volumio sudo[8097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:32 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 17:37:32 volumio sudo[8097]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:33 volumio wpa_supplicant[7795]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING Jan 25 17:37:33 volumio wpa_supplicant[7795]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Jan 25 17:37:33 volumio sudo[8099]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 25 17:37:33 volumio sudo[8099]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:33 volumio dhcpcd[696]: eth0: soliciting a DHCP lease Jan 25 17:37:33 volumio sudo[8099]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:33 volumio wpa_supplicant[7795]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Jan 25 17:37:33 volumio wpa_supplicant[7795]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jan 25 17:37:33 volumio dhcpcd[696]: eth0: offered 192.168.178.101 from 192.168.178.1 Jan 25 17:37:33 volumio dhcpcd[696]: eth0: probing address 192.168.178.101/24 Jan 25 17:37:33 volumio sudo[8108]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 17:37:33 volumio sudo[8108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:33 volumio sudo[8108]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:33 volumio wpa_supplicant[7795]: wlan0: CTRL-EVENT-TERMINATING Jan 25 17:37:33 volumio sudo[8111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 25 17:37:33 volumio sudo[8111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 17:37:33 volumio sudo[8111]: pam_unix(sudo:session): session closed for user root Jan 25 17:37:33 volumio wireless.js[630]: command failed: Network is down (-100) Jan 25 17:37:33 volumio wireless.js[630]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Jan 25 17:37:33 volumio wireless.js[630]: WIRELESS.JS: Notified systemd about wireless ready Jan 25 17:37:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Jan 25 17:37:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:35 volumio go-librespot[8116]: go-librespot daemon starting... Jan 25 17:37:35 volumio go-librespot[8117]: time="2026-01-25T17:37:35+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:35 volumio go-librespot[8117]: time="2026-01-25T17:37:35+01:00" level=debug msg="app state loaded" Jan 25 17:37:35 volumio go-librespot[8117]: time="2026-01-25T17:37:35+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:35 volumio go-librespot[8117]: time="2026-01-25T17:37:35+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:37:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:37:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:37:35 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:35 volumio volumio[7357]: info: Error connecting to go-librespot Websocket: AggregateError Jan 25 17:37:37 volumio dhcpcd[696]: eth0: leased 192.168.178.101 for 86400 seconds Jan 25 17:37:37 volumio avahi-daemon[616]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.101. Jan 25 17:37:37 volumio dhcpcd[696]: eth0: adding route to 192.168.178.0/24 Jan 25 17:37:37 volumio dhcpcd[696]: eth0: adding default route via 192.168.178.1 Jan 25 17:37:37 volumio avahi-daemon[616]: New relevant interface eth0.IPv4 for mDNS. Jan 25 17:37:37 volumio avahi-daemon[616]: Registering new address record for 192.168.178.101 on eth0.IPv4. Jan 25 17:37:37 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jan 25 17:37:37 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jan 25 17:37:37 volumio systemd[1]: welcome.service: Deactivated successfully. Jan 25 17:37:37 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jan 25 17:37:37 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jan 25 17:37:37 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jan 25 17:37:37 volumio welcome[8146]: Resolved ip:[1] 192.168.178.101 Jan 25 17:37:37 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jan 25 17:37:37 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jan 25 17:37:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Jan 25 17:37:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 25 17:37:38 volumio go-librespot[8157]: go-librespot daemon starting... Jan 25 17:37:38 volumio go-librespot[8158]: time="2026-01-25T17:37:38+01:00" level=info msg="running go-librespot 0.6.2" Jan 25 17:37:38 volumio go-librespot[8158]: time="2026-01-25T17:37:38+01:00" level=debug msg="app state loaded" Jan 25 17:37:38 volumio go-librespot[8158]: time="2026-01-25T17:37:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 25 17:37:38 volumio kernel: hwmon hwmon1: Voltage normalised Jan 25 17:37:38 volumio volumio[7357]: info: Initializing connection to go-librespot Websocket Jan 25 17:37:38 volumio go-librespot[8158]: time="2026-01-25T17:37:38+01:00" level=debug msg="new websocket client" Jan 25 17:37:38 volumio volumio[7357]: info: Connection to go-librespot Websocket established Jan 25 17:37:39 volumio ntpd[968]: IO: Listen normally on 7 eth0 192.168.178.101:123 Jan 25 17:37:39 volumio ntpd[968]: IO: new interface(s) found: waking up resolver Jan 25 17:37:39 volumio ntpd[968]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 25 17:37:41 volumio volumio[7357]: info: Getting Spotify volume Jan 25 17:37:42 volumio volumio[7357]: info: Volumio Network Manager: Network status updated: 1 Jan 25 17:38:06 volumio volumio[7357]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 25 17:38:06 volumio volumio[7357]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 25 17:38:06 volumio go-librespot[8158]: time="2026-01-25T17:38:06+01:00" level=fatal msg="failed running with username and spotify token" 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" Jan 25 17:38:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 25 17:38:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 25 17:38:06 volumio volumio[7357]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 17:38:06 volumio volumio[7357]: Error: socket hang up Jan 25 17:38:06 volumio volumio[7357]: at connResetException (node:internal/errors:720:14) Jan 25 17:38:06 volumio volumio[7357]: at Socket.socketOnEnd (node:_http_client:519:23) Jan 25 17:38:06 volumio volumio[7357]: at Socket.emit (node:events:526:35) Jan 25 17:38:06 volumio volumio[7357]: at endReadableNT (node:internal/streams/readable:1376:12) Jan 25 17:38:06 volumio volumio[7357]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Jan 25 17:38:06 volumio volumio[7357]: code: 'ECONNRESET', Jan 25 17:38:06 volumio volumio[7357]: response: undefined Jan 25 17:38:06 volumio volumio[7357]: } Jan 25 17:38:06 volumio volumio[7357]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 17:38:07 volumio sudo[8232]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 17:37' Jan 25 17:38:07 volumio sudo[8232]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"