Mar 24 18:31:04 volumionp volumio[1281]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=aeff57a7b5049f59e6a4a16d36792615" http://updates.volumio.org/downloader-v1/track-device Mar 24 18:31:04 volumionp volumio[1281]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 24 18:31:04 volumionp volumio[1281]: Dload Upload Total Spent Left Speed Mar 24 18:31:04 volumionp volumio[1281]: [11.1K blob data] Mar 24 18:31:04 volumionp volumio[1281]: curl: (28) Failed to connect to updates.volumio.org port 80 after 142603 ms: Couldn't connect to server Mar 24 18:31:04 volumionp volumio[1281]: retrying in 5 seconds, trial 1 Mar 24 18:31:04 volumionp volumio[1281]: info: Volumio Calling Home Mar 24 18:31:30 volumionp kernel: logitech-hidpp-device 0003:046D:4023.0003: HID++ 2.0 device connected. Mar 24 18:31:38 volumionp login[1314]: pam_unix(login:session): session opened for user volumio(uid=1000) by LOGIN(uid=0) Mar 24 18:31:38 volumionp systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Mar 24 18:31:38 volumionp systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Mar 24 18:31:38 volumionp systemd-logind[779]: New session 1 of user volumio. Mar 24 18:31:38 volumionp systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Mar 24 18:31:38 volumionp systemd[1]: Starting user@1000.service - User Manager for UID 1000... Mar 24 18:31:38 volumionp (systemd)[2656]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Mar 24 18:31:39 volumionp systemd[2656]: Queued start job for default target default.target. Mar 24 18:31:39 volumionp systemd[2656]: Created slice app.slice - User Application Slice. Mar 24 18:31:39 volumionp systemd[2656]: Reached target paths.target - Paths. Mar 24 18:31:39 volumionp systemd[2656]: Reached target timers.target - Timers. Mar 24 18:31:39 volumionp systemd[2656]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Mar 24 18:31:39 volumionp systemd[2656]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 24 18:31:39 volumionp systemd[2656]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Mar 24 18:31:39 volumionp systemd[2656]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Mar 24 18:31:39 volumionp systemd[2656]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Mar 24 18:31:39 volumionp systemd[2656]: Reached target sockets.target - Sockets. Mar 24 18:31:39 volumionp systemd[2656]: Reached target basic.target - Basic System. Mar 24 18:31:39 volumionp systemd[1]: Started user@1000.service - User Manager for UID 1000. Mar 24 18:31:39 volumionp systemd[2656]: Started mpris-proxy.service - Bluetooth mpris proxy. Mar 24 18:31:39 volumionp systemd[2656]: Reached target default.target - Main User Target. Mar 24 18:31:39 volumionp systemd[2656]: Startup finished in 519ms. Mar 24 18:31:39 volumionp systemd[1]: Started session-1.scope - Session 1 of User volumio. Mar 24 18:31:39 volumionp mpris-proxy[2685]: Can't get on session bus Mar 24 18:31:39 volumionp systemd[2656]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE Mar 24 18:31:39 volumionp systemd[2656]: mpris-proxy.service: Failed with result 'exit-code'. Mar 24 18:32:07 volumionp dhcpcd[804]: eth0: carrier lost Mar 24 18:32:07 volumionp dhcpcd[755]: eth0: carrier lost Mar 24 18:32:07 volumionp kernel: bcmgenet fd580000.ethernet eth0: Link is Down Mar 24 18:32:07 volumionp avahi-daemon[771]: Withdrawing address record for 192.168.11.201 on eth0. Mar 24 18:32:07 volumionp avahi-daemon[771]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.11.201. Mar 24 18:32:07 volumionp avahi-daemon[771]: Interface eth0.IPv4 no longer relevant for mDNS. Mar 24 18:32:07 volumionp dhcpcd[755]: eth0: deleting route to 192.168.11.0/24 Mar 24 18:32:07 volumionp dhcpcd[755]: eth0: deleting default route via 192.168.11.1 Mar 24 18:32:07 volumionp volumio[1281]: info: Discovery: A device disappeared from network Mar 24 18:32:07 volumionp dhcpcd[804]: eth0: deleting route to 192.168.11.0/24 Mar 24 18:32:07 volumionp dhcpcd[804]: eth0: deleting default route via 192.168.11.1 Mar 24 18:32:07 volumionp volumio[1281]: info: Discovery: A device disappeared from network Mar 24 18:32:07 volumionp systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 18:32:07 volumionp systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Mar 24 18:32:07 volumionp systemd[1]: welcome.service: Deactivated successfully. Mar 24 18:32:07 volumionp systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 24 18:32:07 volumionp systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 24 18:32:07 volumionp systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 24 18:32:07 volumionp welcome[2773]: Resolved ip:[0] Mar 24 18:32:07 volumionp systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 24 18:32:07 volumionp systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 18:32:07 volumionp volumio[1281]: info: Received Get System Info Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 18:32:07 volumionp volumio[1281]: info: Discovery: Getting this device information Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::volumioGetState Mar 24 18:32:07 volumionp volumio[1281]: info: CorePlayQueue::getTrack 0 Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 24 18:32:07 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 24 18:32:08 volumionp ifplugd(eth0)[1031]: Link beat lost. Mar 24 18:32:08 volumionp volumio5-onboarding[1482]: time=2026-03-24T17:32:08.752Z level=INFO msg="service successfully established" component=discovery/localnet Mar 24 18:32:08 volumionp volumio[1281]: info: Volumio Network Manager: Network status updated: 0 Mar 24 18:32:08 volumionp ntpd[1037]: IO: Deleting interface #3 eth0, 192.168.11.201#123, interface stats: received=0, sent=84, dropped=0, active_time=381 secs Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 195.133.18.24 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 194.182.84.172 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 162.159.200.1 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 37.221.242.99 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 46.28.110.153 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 81.25.28.124 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 85.163.168.227 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 194.182.80.44 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 5.45.97.204 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 188.124.59.142 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 5.1.56.123 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 212.132.97.26 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 147.251.48.140 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 93.99.104.53 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 176.118.170.235 unlink local addr 192.168.11.201 -> Mar 24 18:32:08 volumionp ntpd[1037]: PROTO: 81.27.192.20 unlink local addr 192.168.11.201 -> Mar 24 18:32:10 volumionp nmbd[2161]: [2026/03/24 18:32:10.851123, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Mar 24 18:32:10 volumionp nmbd[2161]: Packet send failed to 192.168.11.255(138) ERRNO=Network is unreachable Mar 24 18:32:12 volumionp dhcpcd[804]: eth0: carrier acquired Mar 24 18:32:12 volumionp dhcpcd[755]: eth0: carrier acquired Mar 24 18:32:12 volumionp dhcpcd[804]: eth0: config file changed, expiring leases Mar 24 18:32:12 volumionp dhcpcd[755]: eth0: config file changed, expiring leases Mar 24 18:32:12 volumionp dhcpcd[804]: eth0: IAID 32:d8:e4:25 Mar 24 18:32:12 volumionp dhcpcd[755]: eth0: IAID 32:d8:e4:25 Mar 24 18:32:12 volumionp kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Mar 24 18:32:13 volumionp volumio[1281]: info: Received Get System Info Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 18:32:13 volumionp volumio[1281]: info: Discovery: Getting this device information Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::volumioGetState Mar 24 18:32:13 volumionp volumio[1281]: info: CorePlayQueue::getTrack 0 Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 24 18:32:13 volumionp volumio[1281]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 24 18:32:13 volumionp dhcpcd[804]: eth0: soliciting an IPv6 router Mar 24 18:32:13 volumionp dhcpcd[755]: eth0: soliciting an IPv6 router Mar 24 18:32:13 volumionp ifplugd(eth0)[1031]: Link beat detected. Mar 24 18:32:13 volumionp dhcpcd[755]: eth0: rebinding lease of 192.168.11.201 Mar 24 18:32:13 volumionp dhcpcd[755]: eth0: NAK: requested address not available from 10.20.255.250 Mar 24 18:32:13 volumionp dhcpcd[755]: eth0: message: requested address not available Mar 24 18:32:13 volumionp dhcpcd[755]: eth0: soliciting a DHCP lease Mar 24 18:32:13 volumionp volumio5-onboarding[1482]: time=2026-03-24T17:32:13.920Z level=INFO msg="service successfully established" component=discovery/localnet Mar 24 18:32:14 volumionp dhcpcd[804]: eth0: soliciting a DHCP lease Mar 24 18:32:14 volumionp dhcpcd[755]: eth0: offered 10.20.255.226 from 10.20.255.250 Mar 24 18:32:14 volumionp dhcpcd[755]: eth0: probing address 10.20.255.226/24 Mar 24 18:32:18 volumionp dhcpcd[804]: eth0: offered 10.20.255.226 from 10.20.255.250 Mar 24 18:32:18 volumionp dhcpcd[804]: eth0: probing address 10.20.255.226/24 Mar 24 18:32:19 volumionp dhcpcd[755]: eth0: leased 10.20.255.226 for 300 seconds Mar 24 18:32:19 volumionp dhcpcd[755]: eth0: adding route to 10.20.255.0/24 Mar 24 18:32:19 volumionp avahi-daemon[771]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.20.255.226. Mar 24 18:32:19 volumionp avahi-daemon[771]: New relevant interface eth0.IPv4 for mDNS. Mar 24 18:32:19 volumionp avahi-daemon[771]: Registering new address record for 10.20.255.226 on eth0.IPv4. Mar 24 18:32:19 volumionp dhcpcd[755]: eth0: adding default route via 10.20.255.254 Mar 24 18:32:19 volumionp systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 18:32:19 volumionp systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Mar 24 18:32:19 volumionp systemd[1]: welcome.service: Deactivated successfully. Mar 24 18:32:19 volumionp systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 24 18:32:19 volumionp systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 24 18:32:19 volumionp systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 24 18:32:19 volumionp welcome[2844]: Resolved ip:[1] 10.20.255.226 Mar 24 18:32:19 volumionp systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 24 18:32:19 volumionp systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 18:32:19 volumionp volumio[1281]: compat.c: read() failed: Resource temporarily unavailable Mar 24 18:32:19 volumionp volumio[1281]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 18:32:19 volumionp volumio[1281]: Error: dns service error: unknown Mar 24 18:32:19 volumionp volumio[1281]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Mar 24 18:32:19 volumionp volumio[1281]: errorCode: -65537 Mar 24 18:32:19 volumionp volumio[1281]: } Mar 24 18:32:19 volumionp volumio[1281]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 18:32:19 volumionp sudo[2869]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-24 18:31' Mar 24 18:32:19 volumionp sudo[2869]: 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"