Apr 07 23:44:00 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:00 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 07 23:44:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Apr 07 23:44:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:02 volumio go-librespot[9702]: go-librespot daemon starting... Apr 07 23:44:02 volumio go-librespot[9703]: time="2026-04-07T23:44:02+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:02 volumio go-librespot[9703]: time="2026-04-07T23:44:02+02:00" level=debug msg="app state loaded" Apr 07 23:44:02 volumio go-librespot[9703]: time="2026-04-07T23:44:02+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:02 volumio go-librespot[9703]: time="2026-04-07T23:44:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:02 volumio go-librespot[9703]: time="2026-04-07T23:44:02+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" Apr 07 23:44:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:03 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:03 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 07 23:44:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Apr 07 23:44:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:05 volumio go-librespot[9711]: go-librespot daemon starting... Apr 07 23:44:05 volumio go-librespot[9712]: time="2026-04-07T23:44:05+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:05 volumio go-librespot[9712]: time="2026-04-07T23:44:05+02:00" level=debug msg="app state loaded" Apr 07 23:44:05 volumio go-librespot[9712]: time="2026-04-07T23:44:05+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:05 volumio go-librespot[9712]: time="2026-04-07T23:44:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:05 volumio go-librespot[9712]: time="2026-04-07T23:44:05+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" Apr 07 23:44:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:05 volumio volumio[9221]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=9261c1f6c65fd5ff6cbba5a76002207f" http://updates.volumio.org/downloader-v1/track-device Apr 07 23:44:05 volumio volumio[9221]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 07 23:44:05 volumio volumio[9221]: Dload Upload Total Spent Left Speed Apr 07 23:44:05 volumio volumio[9221]: [132B blob data] Apr 07 23:44:05 volumio volumio[9221]: retrying in 5 seconds, trial 1 Apr 07 23:44:05 volumio volumio[9221]: info: Volumio Calling Home Apr 07 23:44:06 volumio dhcpcd[941]: eth0: carrier acquired Apr 07 23:44:06 volumio dhcpcd[941]: eth0: IAID dd:37:74:56 Apr 07 23:44:06 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 07 23:44:06 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:06 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 07 23:44:07 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:07.077+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 07 23:44:07 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:07 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:07 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:07 volumio ifplugd(eth0)[1026]: Link beat detected. Apr 07 23:44:07 volumio ifplugd(eth0)[1026]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 07 23:44:07 volumio dhcpcd[941]: eth0: soliciting an IPv6 router Apr 07 23:44:07 volumio dhcpcd[941]: eth0: rebinding lease of 192.168.1.241 Apr 07 23:44:07 volumio ifplugd(eth0)[1026]: client: sending commands to dhcpcd process Apr 07 23:44:07 volumio dhcpcd[941]: ps_ctl_dispatch: cannot handle another client Apr 07 23:44:07 volumio dhcpcd[941]: control_free: No such file or directory Apr 07 23:44:07 volumio volumio[9221]: error: MyVolumio Plugin failed to start in a timely fashion Apr 07 23:44:07 volumio volumio[9221]: [Metrics] CommandRouter: 26s 881.97ms Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::volumiosetStartupVolume Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:44:07 volumio volumio[9221]: info: VolumeController:: Setting startup Volume 20 Apr 07 23:44:07 volumio volumio[9221]: info: VolumeController::SetAlsaVolume20 Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::Close All Modals sent Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::Close All Modals sent Apr 07 23:44:07 volumio volumio[9221]: info: CoreStateMachine::pushState Apr 07 23:44:07 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 23:44:07 volumio volumio[9221]: info: CoreCommandRouter::volumioPushState Apr 07 23:44:07 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:07.453+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" state=STATUS_STOPPED positionMs=0 volume=20 Apr 07 23:44:07 volumio volumio[9221]: info: FusionDsp - Volumio is not playing Apr 07 23:44:07 volumio volumio[9221]: info: FusionDsp - Clipped samples monitor stopped Apr 07 23:44:07 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Apr 07 23:44:07 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:07.508+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" id= title= Apr 07 23:44:07 volumio ifplugd(eth0)[1026]: Program executed successfully. Apr 07 23:44:07 volumio volumio[9221]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 07 23:44:07 volumio volumio[9221]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 07 23:44:07 volumio volumio[9221]: info: camilladsp stopping service pid 9502... Apr 07 23:44:07 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:07.944+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:08 volumio volumio[9221]: grep: /proc/9502/cmdline: binary file matches Apr 07 23:44:08 volumio volumio[9221]: grep: /proc/9502/cmdline: binary file matches Apr 07 23:44:08 volumio volumio[9221]: grep: /proc/9502/cmdline: binary file matches Apr 07 23:44:08 volumio volumio[9221]: grep: /proc/9502/cmdline: binary file matches Apr 07 23:44:08 volumio volumio[9221]: grep: /proc/9502/cmdline: binary file matches Apr 07 23:44:08 volumio volumio[9221]: info: camilladsp service terminated, instance 1 Apr 07 23:44:08 volumio volumio[9221]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 07 23:44:08 volumio volumio[9221]: info: camilladsp service started and running in background, instance 1 Apr 07 23:44:08 volumio volumio[9221]: info: camilladsp respawn in 100 ms (attempt 1/10) Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: === SNM TRANSITION === Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: New ethernet state: connected Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: Single Network Mode: enabled Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: First start: no Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: === END TRANSITION === Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Apr 07 23:44:08 volumio sudo[9799]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Apr 07 23:44:08 volumio sudo[9799]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 07 23:44:08 volumio dhcpcd[9807]: dhcpcd not running Apr 07 23:44:08 volumio sudo[9799]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:08 volumio wireless.js[744]: dhcpcd not running Apr 07 23:44:08 volumio wireless.js[744]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Apr 07 23:44:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Apr 07 23:44:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:08 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 07 23:44:08 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 07 23:44:08 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 07 23:44:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:08 volumio go-librespot[9812]: go-librespot daemon starting... Apr 07 23:44:08 volumio go-librespot[9815]: time="2026-04-07T23:44:08+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:08 volumio go-librespot[9815]: time="2026-04-07T23:44:08+02:00" level=debug msg="app state loaded" Apr 07 23:44:08 volumio go-librespot[9815]: time="2026-04-07T23:44:08+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:08 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Apr 07 23:44:08 volumio dnsmasq[9651]: exiting on receipt of SIGTERM Apr 07 23:44:08 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Apr 07 23:44:08 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Apr 07 23:44:08 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Apr 07 23:44:08 volumio go-librespot[9815]: time="2026-04-07T23:44:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:08 volumio go-librespot[9815]: time="2026-04-07T23:44:08+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" Apr 07 23:44:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:09 volumio dhcpcd[941]: wlan0: carrier lost Apr 07 23:44:09 volumio systemd[1]: hostapd.service: Deactivated successfully. Apr 07 23:44:09 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Apr 07 23:44:09 volumio sudo[9833]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 07 23:44:09 volumio sudo[9833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 07 23:44:09 volumio avahi-daemon[721]: Withdrawing address record for 192.168.211.1 on wlan0. Apr 07 23:44:09 volumio avahi-daemon[721]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 07 23:44:09 volumio sudo[9833]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:09 volumio avahi-daemon[721]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 07 23:44:09 volumio volumio[9221]: info: Discovery: A device disappeared from network Apr 07 23:44:09 volumio sudo[9842]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 07 23:44:09 volumio sudo[9842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 07 23:44:09 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Apr 07 23:44:09 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Apr 07 23:44:09 volumio systemd[1]: welcome.service: Deactivated successfully. Apr 07 23:44:09 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Apr 07 23:44:09 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Apr 07 23:44:09 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Apr 07 23:44:09 volumio welcome[9844]: Resolved ip:[0] Apr 07 23:44:09 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:09 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:09 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:09.666+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 07 23:44:09 volumio sudo[9842]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:09 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:09 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:09 volumio wireless.js[744]: WIRELESS.JS - INFO: Cleaning previous... Apr 07 23:44:09 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Apr 07 23:44:09 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Apr 07 23:44:09 volumio sudo[9849]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 07 23:44:09 volumio sudo[9849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 07 23:44:09 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:09 volumio sudo[9849]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:09 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 07 23:44:09 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:09 volumio wireless.js[744]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Apr 07 23:44:09 volumio wireless.js[744]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms Apr 07 23:44:09 volumio wireless.js[744]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: d8:3a:dd:37:74:57) Apr 07 23:44:09 volumio sudo[9857]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 07 23:44:09 volumio sudo[9857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 07 23:44:09 volumio sudo[9857]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:09 volumio sudo[9865]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 07 23:44:09 volumio sudo[9865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 07 23:44:10 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:10.234+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 07 23:44:10 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:10 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:10 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:10 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:10 volumio ntpd[1012]: IO: Deleting interface #9 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=16 secs Apr 07 23:44:11 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:11.550+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8. Apr 07 23:44:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:11 volumio go-librespot[9883]: go-librespot daemon starting... Apr 07 23:44:11 volumio go-librespot[9884]: time="2026-04-07T23:44:11+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:11 volumio go-librespot[9884]: time="2026-04-07T23:44:11+02:00" level=debug msg="app state loaded" Apr 07 23:44:11 volumio go-librespot[9884]: time="2026-04-07T23:44:11+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:11 volumio go-librespot[9884]: time="2026-04-07T23:44:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:11 volumio go-librespot[9884]: time="2026-04-07T23:44:11+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" Apr 07 23:44:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:12 volumio dhcpcd[941]: eth0: DHCP lease expired Apr 07 23:44:12 volumio dhcpcd[941]: eth0: soliciting a DHCP lease Apr 07 23:44:12 volumio volumio[9221]: info: camilladsp respawn in 200 ms (attempt 2/10) Apr 07 23:44:12 volumio sudo[9865]: pam_unix(sudo:session): session closed for user root Apr 07 23:44:12 volumio wireless.js[744]: WIRELESS.JS - INFO: Regdomain already correct: US Apr 07 23:44:12 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:12 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:13 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:13.151+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 07 23:44:13 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:13 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:13 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:13 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:14 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:14.014+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:14 volumio volumio[9221]: info: BOOT COMPLETED Apr 07 23:44:14 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 23:44:14 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:44:14 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 07 23:44:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Apr 07 23:44:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:15 volumio go-librespot[9906]: go-librespot daemon starting... Apr 07 23:44:15 volumio go-librespot[9907]: time="2026-04-07T23:44:15+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:15 volumio go-librespot[9907]: time="2026-04-07T23:44:15+02:00" level=debug msg="app state loaded" Apr 07 23:44:15 volumio go-librespot[9907]: time="2026-04-07T23:44:15+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:15 volumio go-librespot[9907]: time="2026-04-07T23:44:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:15 volumio go-librespot[9907]: time="2026-04-07T23:44:15+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" Apr 07 23:44:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:15 volumio volumio[9221]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=9261c1f6c65fd5ff6cbba5a76002207f" http://updates.volumio.org/downloader-v1/track-device Apr 07 23:44:15 volumio volumio[9221]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 07 23:44:15 volumio volumio[9221]: Dload Upload Total Spent Left Speed Apr 07 23:44:15 volumio volumio[9221]: [132B blob data] Apr 07 23:44:15 volumio volumio[9221]: retrying in 5 seconds, trial 2 Apr 07 23:44:15 volumio volumio[9221]: info: Volumio Calling Home Apr 07 23:44:15 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:15 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Apr 07 23:44:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:18 volumio go-librespot[9918]: go-librespot daemon starting... Apr 07 23:44:18 volumio go-librespot[9919]: time="2026-04-07T23:44:18+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:18 volumio go-librespot[9919]: time="2026-04-07T23:44:18+02:00" level=debug msg="app state loaded" Apr 07 23:44:18 volumio go-librespot[9919]: time="2026-04-07T23:44:18+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:18 volumio go-librespot[9919]: time="2026-04-07T23:44:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:18 volumio go-librespot[9919]: time="2026-04-07T23:44:18+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" Apr 07 23:44:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:18 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:18 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Apr 07 23:44:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:21 volumio go-librespot[9927]: go-librespot daemon starting... Apr 07 23:44:21 volumio go-librespot[9928]: time="2026-04-07T23:44:21+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:21 volumio go-librespot[9928]: time="2026-04-07T23:44:21+02:00" level=debug msg="app state loaded" Apr 07 23:44:21 volumio go-librespot[9928]: time="2026-04-07T23:44:21+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:21 volumio go-librespot[9928]: time="2026-04-07T23:44:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:21 volumio go-librespot[9928]: time="2026-04-07T23:44:21+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" Apr 07 23:44:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:21 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:21 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Apr 07 23:44:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:24 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:24 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:24 volumio go-librespot[9951]: go-librespot daemon starting... Apr 07 23:44:24 volumio go-librespot[9952]: time="2026-04-07T23:44:24+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:24 volumio go-librespot[9952]: time="2026-04-07T23:44:24+02:00" level=debug msg="app state loaded" Apr 07 23:44:24 volumio go-librespot[9952]: time="2026-04-07T23:44:24+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:24 volumio go-librespot[9952]: time="2026-04-07T23:44:24+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:24 volumio go-librespot[9952]: time="2026-04-07T23:44:24+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" Apr 07 23:44:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:27 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:27 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Apr 07 23:44:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:28 volumio go-librespot[9960]: go-librespot daemon starting... Apr 07 23:44:28 volumio go-librespot[9961]: time="2026-04-07T23:44:28+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:28 volumio go-librespot[9961]: time="2026-04-07T23:44:28+02:00" level=debug msg="app state loaded" Apr 07 23:44:28 volumio go-librespot[9961]: time="2026-04-07T23:44:28+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:28 volumio go-librespot[9961]: time="2026-04-07T23:44:28+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:28 volumio go-librespot[9961]: time="2026-04-07T23:44:28+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" Apr 07 23:44:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:30 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:30 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Apr 07 23:44:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:31 volumio go-librespot[9969]: go-librespot daemon starting... Apr 07 23:44:31 volumio go-librespot[9970]: time="2026-04-07T23:44:31+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:31 volumio go-librespot[9970]: time="2026-04-07T23:44:31+02:00" level=debug msg="app state loaded" Apr 07 23:44:31 volumio go-librespot[9970]: time="2026-04-07T23:44:31+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:31 volumio go-librespot[9970]: time="2026-04-07T23:44:31+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:31 volumio go-librespot[9970]: time="2026-04-07T23:44:31+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" Apr 07 23:44:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:31 volumio dhcpcd[941]: eth0: carrier lost Apr 07 23:44:31 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Apr 07 23:44:31 volumio ifplugd(eth0)[1026]: Link beat lost. Apr 07 23:44:32 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:32.036+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 07 23:44:32 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:32 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:32 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:32 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:32 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:32.888+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:33 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:33 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Apr 07 23:44:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:34 volumio go-librespot[10006]: go-librespot daemon starting... Apr 07 23:44:34 volumio go-librespot[10007]: time="2026-04-07T23:44:34+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:34 volumio go-librespot[10007]: time="2026-04-07T23:44:34+02:00" level=debug msg="app state loaded" Apr 07 23:44:34 volumio go-librespot[10007]: time="2026-04-07T23:44:34+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:34 volumio go-librespot[10007]: time="2026-04-07T23:44:34+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:34 volumio go-librespot[10007]: time="2026-04-07T23:44:34+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" Apr 07 23:44:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:34 volumio dhcpcd[941]: eth0: carrier acquired Apr 07 23:44:34 volumio dhcpcd[941]: eth0: IAID dd:37:74:56 Apr 07 23:44:34 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 07 23:44:34 volumio ifplugd(eth0)[1026]: Link beat detected. Apr 07 23:44:35 volumio dhcpcd[941]: eth0: soliciting a DHCP lease Apr 07 23:44:35 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:35 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:35 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:35.159+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 07 23:44:35 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:35 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:35 volumio dhcpcd[941]: eth0: soliciting an IPv6 router Apr 07 23:44:36 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:36.011+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:36 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:36 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Apr 07 23:44:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:37 volumio go-librespot[10017]: go-librespot daemon starting... Apr 07 23:44:37 volumio go-librespot[10018]: time="2026-04-07T23:44:37+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:37 volumio go-librespot[10018]: time="2026-04-07T23:44:37+02:00" level=debug msg="app state loaded" Apr 07 23:44:37 volumio go-librespot[10018]: time="2026-04-07T23:44:37+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:37 volumio go-librespot[10018]: time="2026-04-07T23:44:37+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:37 volumio go-librespot[10018]: time="2026-04-07T23:44:37+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" Apr 07 23:44:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:39 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:39 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Apr 07 23:44:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:41 volumio go-librespot[10026]: go-librespot daemon starting... Apr 07 23:44:41 volumio go-librespot[10027]: time="2026-04-07T23:44:41+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:41 volumio go-librespot[10027]: time="2026-04-07T23:44:41+02:00" level=debug msg="app state loaded" Apr 07 23:44:41 volumio go-librespot[10027]: time="2026-04-07T23:44:41+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:41 volumio go-librespot[10027]: time="2026-04-07T23:44:41+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:41 volumio go-librespot[10027]: time="2026-04-07T23:44:41+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" Apr 07 23:44:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:42 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:42 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Apr 07 23:44:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:44 volumio go-librespot[10050]: go-librespot daemon starting... Apr 07 23:44:44 volumio go-librespot[10051]: time="2026-04-07T23:44:44+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:44 volumio go-librespot[10051]: time="2026-04-07T23:44:44+02:00" level=debug msg="app state loaded" Apr 07 23:44:44 volumio go-librespot[10051]: time="2026-04-07T23:44:44+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:44 volumio go-librespot[10051]: time="2026-04-07T23:44:44+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:44 volumio go-librespot[10051]: time="2026-04-07T23:44:44+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" Apr 07 23:44:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:45 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:45 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Apr 07 23:44:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:47 volumio go-librespot[10059]: go-librespot daemon starting... Apr 07 23:44:47 volumio go-librespot[10060]: time="2026-04-07T23:44:47+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:47 volumio go-librespot[10060]: time="2026-04-07T23:44:47+02:00" level=debug msg="app state loaded" Apr 07 23:44:47 volumio go-librespot[10060]: time="2026-04-07T23:44:47+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:47 volumio go-librespot[10060]: time="2026-04-07T23:44:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:47 volumio go-librespot[10060]: time="2026-04-07T23:44:47+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" Apr 07 23:44:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:48 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:48 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Apr 07 23:44:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:50 volumio go-librespot[10068]: go-librespot daemon starting... Apr 07 23:44:50 volumio go-librespot[10069]: time="2026-04-07T23:44:50+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:50 volumio go-librespot[10069]: time="2026-04-07T23:44:50+02:00" level=debug msg="app state loaded" Apr 07 23:44:50 volumio go-librespot[10069]: time="2026-04-07T23:44:50+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:50 volumio go-librespot[10069]: time="2026-04-07T23:44:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:50 volumio go-librespot[10069]: time="2026-04-07T23:44:50+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" Apr 07 23:44:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:51 volumio dhcpcd[941]: eth0: offered 192.168.1.241 from 192.168.1.1 Apr 07 23:44:51 volumio dhcpcd[941]: eth0: probing address 192.168.1.241/24 Apr 07 23:44:51 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:51 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Apr 07 23:44:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:54 volumio go-librespot[10092]: go-librespot daemon starting... Apr 07 23:44:54 volumio go-librespot[10093]: time="2026-04-07T23:44:54+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:54 volumio go-librespot[10093]: time="2026-04-07T23:44:54+02:00" level=debug msg="app state loaded" Apr 07 23:44:54 volumio go-librespot[10093]: time="2026-04-07T23:44:54+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:54 volumio go-librespot[10093]: time="2026-04-07T23:44:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:54 volumio go-librespot[10093]: time="2026-04-07T23:44:54+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" Apr 07 23:44:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:44:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:44:54 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:54 volumio volumio[9221]: info: Error connecting to go-librespot Websocket: AggregateError Apr 07 23:44:55 volumio dhcpcd[941]: eth0: leased 192.168.1.241 for 86400 seconds Apr 07 23:44:55 volumio avahi-daemon[721]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.241. Apr 07 23:44:55 volumio avahi-daemon[721]: New relevant interface eth0.IPv4 for mDNS. Apr 07 23:44:55 volumio avahi-daemon[721]: Registering new address record for 192.168.1.241 on eth0.IPv4. Apr 07 23:44:55 volumio dhcpcd[941]: eth0: adding route to 192.168.1.0/24 Apr 07 23:44:55 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Apr 07 23:44:55 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Apr 07 23:44:55 volumio systemd[1]: welcome.service: Deactivated successfully. Apr 07 23:44:55 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Apr 07 23:44:55 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Apr 07 23:44:55 volumio dhcpcd[941]: eth0: adding default route via 192.168.1.1 Apr 07 23:44:55 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Apr 07 23:44:55 volumio welcome[10116]: Resolved ip:[1] 192.168.1.241 Apr 07 23:44:55 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Apr 07 23:44:55 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Apr 07 23:44:56 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:56.233+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%02 @ 0x2ec64e0" available=true connected=true macAddress=d8:3a:dd:37:74:56 ip4Address=192.168.1.241/24 ip6Address= Apr 07 23:44:56 volumio volumio[9221]: info: Received Get System Info Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 23:44:56 volumio volumio[9221]: info: Discovery: Getting this device information Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:56 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:44:56 volumio volumio[9221]: info: Discovery: adding 29539693-a003-4b6e-8093-832183cfb0e8 Apr 07 23:44:56 volumio volumio[9221]: info: Discovery: Found device Volumio Apr 07 23:44:56 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:44:56 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:44:56 volumio ntpd[1012]: IO: Listen normally on 10 eth0 192.168.1.241:123 Apr 07 23:44:56 volumio ntpd[1012]: IO: new interface(s) found: waking up resolver Apr 07 23:44:56 volumio ntpd[1012]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Apr 07 23:44:56 volumio ntpd[1012]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Apr 07 23:44:56 volumio ntpd[1012]: DNS: Pool skipping: 10.0.0.1 Apr 07 23:44:56 volumio ntpd[1012]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Apr 07 23:44:57 volumio volumio5-onboarding[1554]: time=2026-04-07T23:44:57.167+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 07 23:44:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Apr 07 23:44:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 07 23:44:57 volumio go-librespot[10127]: go-librespot daemon starting... Apr 07 23:44:57 volumio go-librespot[10128]: time="2026-04-07T23:44:57+02:00" level=info msg="running go-librespot 0.7.1" Apr 07 23:44:57 volumio go-librespot[10128]: time="2026-04-07T23:44:57+02:00" level=debug msg="app state loaded" Apr 07 23:44:57 volumio go-librespot[10128]: time="2026-04-07T23:44:57+02:00" level=debug msg="stored credentials not found" Apr 07 23:44:57 volumio go-librespot[10128]: time="2026-04-07T23:44:57+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 07 23:44:57 volumio volumio[9221]: info: Initializing connection to go-librespot Websocket Apr 07 23:44:57 volumio go-librespot[10128]: time="2026-04-07T23:44:57+02:00" level=debug msg="new websocket client" Apr 07 23:44:57 volumio volumio[9221]: info: Connection to go-librespot Websocket established Apr 07 23:44:57 volumio ntpd[1012]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Apr 07 23:44:57 volumio ntpd[1012]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Apr 07 23:44:57 volumio ntpd[1012]: DNS: Pool skipping: 10.0.0.1 Apr 07 23:44:57 volumio ntpd[1012]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Apr 07 23:44:58 volumio ntpd[1012]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Apr 07 23:44:58 volumio ntpd[1012]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Apr 07 23:44:58 volumio ntpd[1012]: DNS: Pool skipping: 10.0.0.1 Apr 07 23:44:58 volumio ntpd[1012]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Apr 07 23:44:59 volumio ntpd[1012]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Apr 07 23:44:59 volumio ntpd[1012]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Apr 07 23:44:59 volumio ntpd[1012]: DNS: Pool skipping: 10.0.0.1 Apr 07 23:44:59 volumio ntpd[1012]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Apr 07 23:45:00 volumio volumio[9221]: info: Getting Spotify volume Apr 07 23:45:00 volumio volumio[9221]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 07 23:45:00 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:45:00 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:45:00 volumio volumio[9221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 Apr 07 23:45:00 volumio volumio[9221]: SPOTIFY: SPOTIFY VOLUME undefined Apr 07 23:45:00 volumio volumio[9221]: SPOTIFY: VOLUMIO VOLUME 20 Apr 07 23:45:00 volumio volumio[9221]: info: Aligning Spotify Volume to Volumio Volume Apr 07 23:45:00 volumio volumio[9221]: info: CoreCommandRouter::volumioGetState Apr 07 23:45:00 volumio volumio[9221]: info: CorePlayQueue::getTrack 0 Apr 07 23:45:00 volumio volumio[9221]: info: Setting Spotify Volume from Volumio: 20 Apr 07 23:45:01 volumio volumio[9221]: info: Volumio Network Manager: Network status updated: 1 Apr 07 23:45:02 volumio volumio[9221]: SPOTIFY: SETTING SPOTIFY VOLUME 20 Apr 07 23:45:02 volumio volumio[9221]: info: Sending Spotify command with payload to local API: /player/volume Apr 07 23:45:03 volumio nmbd[1096]: [2026/04/07 23:45:03.154923, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Apr 07 23:45:03 volumio nmbd[1096]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin bluetooth to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin multiroom to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin metavolumio to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin cd_controller to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin qobuzconnect to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 07 23:45:23 volumio volumio[9221]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 07 23:45:24 volumio volumio[9221]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 07 23:45:24 volumio volumio[9221]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 07 23:45:24 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:45:24 volumio volumio[9221]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:45:24 volumio volumio[9221]: info: Starting MyVolumio Remote Streaming Endpoints Apr 07 23:45:24 volumio volumio[9221]: info: MyVolumio login type: Token Apr 07 23:45:24 volumio volumio[9221]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 07 23:45:24 volumio volumio[9221]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 07 23:45:25 volumio volumio[9221]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 07 23:45:25 volumio volumio[9221]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 07 23:45:25 volumio volumio[9221]: info: Streaming services startup Apr 07 23:45:25 volumio volumio[9221]: info: Starting Streaming Daemon Apr 07 23:45:25 volumio sudo[10184]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 07 23:45:25 volumio sudo[10184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 07 23:45:25 volumio volumio[9221]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 07 23:45:25 volumio sudo[10184]: pam_unix(sudo:session): session closed for user root Apr 07 23:45:25 volumio volumio[9221]: error: Cannot start Volumio Streaming Daemon Apr 07 23:45:25 volumio volumio[9221]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 07 23:45:25 volumio volumio[9221]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 07 23:45:26 volumio volumio[9221]: error: MyVolumio Custom Token format not valid, refreshing it Apr 07 23:45:26 volumio volumio[9221]: info: MyVolumio login type: Token Apr 07 23:45:27 volumio volumio[9221]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 07 23:45:27 volumio go-librespot[10128]: time="2026-04-07T23:45:27+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\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" Apr 07 23:45:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:45:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 07 23:45:27 volumio volumio[9221]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Apr 07 23:45:27 volumio volumio[9221]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:45:27 volumio volumio[9221]: Error: socket hang up Apr 07 23:45:27 volumio volumio[9221]: at connResetException (node:internal/errors:720:14) Apr 07 23:45:27 volumio volumio[9221]: at Socket.socketOnEnd (node:_http_client:519:23) Apr 07 23:45:27 volumio volumio[9221]: at Socket.emit (node:events:526:35) Apr 07 23:45:27 volumio volumio[9221]: at endReadableNT (node:internal/streams/readable:1376:12) Apr 07 23:45:27 volumio volumio[9221]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Apr 07 23:45:27 volumio volumio[9221]: code: 'ECONNRESET', Apr 07 23:45:27 volumio volumio[9221]: response: undefined Apr 07 23:45:27 volumio volumio[9221]: } Apr 07 23:45:27 volumio volumio[9221]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:45:27 volumio sudo[10204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-07 23:44' Apr 07 23:45:27 volumio sudo[10204]: 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"