Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: CLOCK: time stepped by 696715.120269 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: CLOCK: time changed from 2026-05-25 to 2026-06-02 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: Pool taking: 45.138.55.61 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: Pool taking: 45.139.163.87 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: Pool taking: 85.121.52.237 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: Pool taking: 129.250.35.251 Jun 02 21:38:05 volumio-huiskamer ntpd[1036]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Jun 02 21:38:05 volumio-huiskamer systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jun 02 21:38:05 volumio-huiskamer systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jun 02 21:38:05 volumio-huiskamer systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jun 02 21:38:05 volumio-huiskamer volumio[1132]: info: Discovery: A device disappeared from network Jun 02 21:38:05 volumio-huiskamer systemd[1]: e2scrub_all.service: Deactivated successfully. Jun 02 21:38:05 volumio-huiskamer systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jun 02 21:38:05 volumio-huiskamer systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jun 02 21:38:05 volumio-huiskamer volumio[1132]: info: Discovery: A device disappeared from network Jun 02 21:38:05 volumio-huiskamer systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jun 02 21:38:05 volumio-huiskamer systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jun 02 21:38:06 volumio-huiskamer sudo[1656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Hans,password=Hp4711**,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.87/Media/Muziek /mnt/NAS/Nas-Server Jun 02 21:38:06 volumio-huiskamer sudo[1656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 21:38:06 volumio-huiskamer kernel: CIFS: Attempting to mount //192.168.0.87/Media/Muziek Jun 02 21:38:06 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Jun 02 21:38:06 volumio-huiskamer systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:06 volumio-huiskamer systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:06 volumio-huiskamer go-librespot[1660]: go-librespot daemon starting... Jun 02 21:38:06 volumio-huiskamer go-librespot[1661]: time="2026-06-02T21:38:06+02:00" level=info msg="running go-librespot 0.7.1" Jun 02 21:38:06 volumio-huiskamer go-librespot[1661]: time="2026-06-02T21:38:06+02:00" level=debug msg="app state loaded" Jun 02 21:38:06 volumio-huiskamer go-librespot[1661]: time="2026-06-02T21:38:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Discovery: adding 04fd8aa2-6c6e-4ad5-9361-7a0ee8fb8ae1 Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Discovery: Found device Volumio-huiskamer Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: CoreCommandRouter::volumioGetState Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: CorePlayQueue::getTrack 0 Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Discovery: this is already registered, 04fd8aa2-6c6e-4ad5-9361-7a0ee8fb8ae1 Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Discovery: Found device Volumio-huiskamer Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: CoreCommandRouter::volumioGetState Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: CorePlayQueue::getTrack 0 Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: [2026/06/02 21:38:07.224892, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: register_name_response: Answer name <00> differs from question name <00>. Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: [2026/06/02 21:38:07.225843, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: register_name_response: Answer name <03> differs from question name <03>. Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: [2026/06/02 21:38:07.226403, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 02 21:38:07 volumio-huiskamer nmbd[1092]: register_name_response: Answer name <20> differs from question name <20>. Jun 02 21:38:07 volumio-huiskamer volumio[1132]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=ebe7534ae3431e84a79ee6eb0449fa0e" http://updates.volumio.org/downloader-v1/track-device Jun 02 21:38:07 volumio-huiskamer volumio[1132]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 02 21:38:07 volumio-huiskamer volumio[1132]: Dload Upload Total Spent Left Speed Jun 02 21:38:07 volumio-huiskamer volumio[1132]: [1.9K blob data] Jun 02 21:38:07 volumio-huiskamer volumio[1132]: retrying in 5 seconds, trial 0 Jun 02 21:38:07 volumio-huiskamer volumio[1132]: info: Volumio Calling Home Jun 02 21:38:08 volumio-huiskamer systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Jun 02 21:38:08 volumio-huiskamer systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:08 volumio-huiskamer systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:08 volumio-huiskamer upmpdcli[1672]: Could not open config: /tmp/upmpdcli.conf Jun 02 21:38:08 volumio-huiskamer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:38:08 volumio-huiskamer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 02 21:38:08 volumio-huiskamer bash[1484]: setdatetime-helper: all HTTPS Date fallbacks failed Jun 02 21:38:08 volumio-huiskamer systemd[1]: setdatetime-helper.service: Deactivated successfully. Jun 02 21:38:08 volumio-huiskamer systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jun 02 21:38:08 volumio-huiskamer systemd[1]: setdatetime-helper.service: Consumed 1.119s CPU time. Jun 02 21:38:12 volumio-huiskamer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 02 21:38:12 volumio-huiskamer kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 02 21:38:12 volumio-huiskamer sudo[1656]: pam_unix(sudo:session): session closed for user root Jun 02 21:38:12 volumio-huiskamer volumio[1132]: info: Cannot mount NAS Nas-Server at system boot, trial number 4 ,retrying in 5 seconds Jun 02 21:38:16 volumio-huiskamer go-librespot[1661]: time="2026-06-02T21:38:16+02: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" Jun 02 21:38:16 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:38:16 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 02 21:38:17 volumio-huiskamer sudo[1690]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Hans,password=Hp4711**,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.87/Media/Muziek /mnt/NAS/Nas-Server Jun 02 21:38:17 volumio-huiskamer sudo[1690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 21:38:17 volumio-huiskamer kernel: CIFS: Attempting to mount //192.168.0.87/Media/Muziek Jun 02 21:38:17 volumio-huiskamer sudo[1690]: pam_unix(sudo:session): session closed for user root Jun 02 21:38:17 volumio-huiskamer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 02 21:38:17 volumio-huiskamer kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 02 21:38:17 volumio-huiskamer volumio[1132]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 02 21:38:20 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Jun 02 21:38:20 volumio-huiskamer systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:20 volumio-huiskamer systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:20 volumio-huiskamer go-librespot[1694]: go-librespot daemon starting... Jun 02 21:38:20 volumio-huiskamer go-librespot[1695]: time="2026-06-02T21:38:20+02:00" level=info msg="running go-librespot 0.7.1" Jun 02 21:38:20 volumio-huiskamer go-librespot[1695]: time="2026-06-02T21:38:20+02:00" level=debug msg="app state loaded" Jun 02 21:38:20 volumio-huiskamer go-librespot[1695]: time="2026-06-02T21:38:20+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 21:38:23 volumio-huiskamer volumio[1132]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo ENOTFOUND oauth-performer.prod.vlmapi.io Jun 02 21:38:23 volumio-huiskamer systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Jun 02 21:38:23 volumio-huiskamer systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:23 volumio-huiskamer systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:23 volumio-huiskamer upmpdcli[1703]: Could not open config: /tmp/upmpdcli.conf Jun 02 21:38:23 volumio-huiskamer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:38:23 volumio-huiskamer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 02 21:38:33 volumio-huiskamer go-librespot[1695]: time="2026-06-02T21:38:33+02:00" level=debug msg="new websocket client" Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: Connection to go-librespot Websocket established Jun 02 21:38:33 volumio-huiskamer volumio[1132]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: Discovery: this is already registered, 04fd8aa2-6c6e-4ad5-9361-7a0ee8fb8ae1 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: Discovery: Found device Volumio-huiskamer Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CoreCommandRouter::volumioGetState Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CorePlayQueue::getTrack 0 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: Discovery: this is already registered, 04fd8aa2-6c6e-4ad5-9361-7a0ee8fb8ae1 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: Discovery: Found device Volumio-huiskamer Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CoreCommandRouter::volumioGetState Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CorePlayQueue::getTrack 0 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CoreCommandRouter::volumioGetState Jun 02 21:38:33 volumio-huiskamer volumio[1132]: info: CorePlayQueue::getTrack 0 Jun 02 21:38:34 volumio-huiskamer volumio[1132]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.119&uuid=ebe7534ae3431e84a79ee6eb0449fa0e" http://updates.volumio.org/downloader-v1/track-device Jun 02 21:38:34 volumio-huiskamer volumio[1132]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 02 21:38:34 volumio-huiskamer volumio[1132]: Dload Upload Total Spent Left Speed Jun 02 21:38:34 volumio-huiskamer volumio[1132]: [1.3K blob data] Jun 02 21:38:34 volumio-huiskamer volumio[1132]: retrying in 5 seconds, trial 1 Jun 02 21:38:34 volumio-huiskamer volumio[1132]: info: Volumio Calling Home Jun 02 21:38:36 volumio-huiskamer volumio[1132]: info: Getting Spotify volume Jun 02 21:38:36 volumio-huiskamer go-librespot[1695]: time="2026-06-02T21:38:36+02: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" Jun 02 21:38:36 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:38:36 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 02 21:38:36 volumio-huiskamer volumio[1132]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:38:36 volumio-huiskamer volumio[1132]: Error: socket hang up Jun 02 21:38:36 volumio-huiskamer volumio[1132]: at connResetException (node:internal/errors:720:14) Jun 02 21:38:36 volumio-huiskamer volumio[1132]: at Socket.socketOnEnd (node:_http_client:519:23) Jun 02 21:38:36 volumio-huiskamer volumio[1132]: at Socket.emit (node:events:526:35) Jun 02 21:38:36 volumio-huiskamer volumio[1132]: at endReadableNT (node:internal/streams/readable:1376:12) Jun 02 21:38:36 volumio-huiskamer volumio[1132]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Jun 02 21:38:36 volumio-huiskamer volumio[1132]: code: 'ECONNRESET', Jun 02 21:38:36 volumio-huiskamer volumio[1132]: response: undefined Jun 02 21:38:36 volumio-huiskamer volumio[1132]: } Jun 02 21:38:36 volumio-huiskamer volumio[1132]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:38:38 volumio-huiskamer systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Jun 02 21:38:38 volumio-huiskamer systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:38 volumio-huiskamer systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 21:38:38 volumio-huiskamer upmpdcli[1748]: Could not open config: /tmp/upmpdcli.conf Jun 02 21:38:38 volumio-huiskamer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:38:38 volumio-huiskamer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 02 21:38:39 volumio-huiskamer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Jun 02 21:38:39 volumio-huiskamer systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:39 volumio-huiskamer systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 21:38:39 volumio-huiskamer go-librespot[1749]: go-librespot daemon starting... Jun 02 21:38:39 volumio-huiskamer go-librespot[1750]: time="2026-06-02T21:38:39+02:00" level=info msg="running go-librespot 0.7.1" Jun 02 21:38:39 volumio-huiskamer go-librespot[1750]: time="2026-06-02T21:38:39+02:00" level=debug msg="app state loaded" Jun 02 21:38:39 volumio-huiskamer go-librespot[1750]: time="2026-06-02T21:38:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 21:38:43 volumio-huiskamer sudo[1761]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-02 21:37' Jun 02 21:38:43 volumio-huiskamer sudo[1761]: 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"