Aug 26 11:40:06 dadadac ntpd[1175]: CLOCK: time stepped by 1366653.875695 Aug 26 11:40:06 dadadac ntpd[1175]: CLOCK: time changed from 2026-08-10 to 2026-08-26 Aug 26 11:40:06 dadadac ntpd[1175]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Aug 26 11:40:06 dadadac systemd[1]: Starting apt-daily-upgrade.service - Daily apt upgrade and clean activities... Aug 26 11:40:06 dadadac systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Aug 26 11:40:06 dadadac systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Aug 26 11:40:06 dadadac systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Aug 26 11:40:06 dadadac systemd[1]: e2scrub_all.service: Deactivated successfully. Aug 26 11:40:06 dadadac systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Aug 26 11:40:06 dadadac systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Aug 26 11:40:06 dadadac systemd[1]: dpkg-db-backup.service: Deactivated successfully. Aug 26 11:40:06 dadadac systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Aug 26 11:40:06 dadadac systemd[1]: apt-daily-upgrade.service: Deactivated successfully. Aug 26 11:40:06 dadadac systemd[1]: Finished apt-daily-upgrade.service - Daily apt upgrade and clean activities. Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: A device disappeared from network Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: Device dadadac disappeared from network Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: A device disappeared from network Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: adding aaa1dee0-484e-4d4c-8c5f-2e2863826315 Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: Found device dadadac Aug 26 11:40:07 dadadac volumio[1266]: info: CoreCommandRouter::volumioGetState Aug 26 11:40:07 dadadac volumio[1266]: info: CorePlayQueue::getTrack 0 Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: this is already registered, aaa1dee0-484e-4d4c-8c5f-2e2863826315 Aug 26 11:40:07 dadadac volumio[1266]: info: Discovery: Found device dadadac Aug 26 11:40:07 dadadac volumio[1266]: info: CoreCommandRouter::volumioGetState Aug 26 11:40:07 dadadac volumio[1266]: info: CorePlayQueue::getTrack 0 Aug 26 11:40:07 dadadac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 429. Aug 26 11:40:07 dadadac systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 26 11:40:07 dadadac systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 26 11:40:07 dadadac go-librespot[7052]: go-librespot daemon starting... Aug 26 11:40:07 dadadac go-librespot[7053]: time="2026-08-26T11:40:07+01:00" level=info msg="running go-librespot 0.7.1" Aug 26 11:40:07 dadadac go-librespot[7053]: time="2026-08-26T11:40:07+01:00" level=debug msg="app state loaded" Aug 26 11:40:07 dadadac go-librespot[7053]: time="2026-08-26T11:40:07+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=info msg="zeroconf server listening on port 41061" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="obtained new client token: AAHu5VQd5eYCXm43Mb0JTe8ZnxS/GgQTmCui3v+BgupPGbi9cnF9Pxgv2Tn86nfgZ8yDSkMPuK8XMf1HVxlyf60cXsm02LW+p5cEEu8ITh5unxr24dVXkYr94dUAoSp9mEHC40+ya8pfyb0H/9liy4ipkmqAbL8wUzI+w0PlOwlecoazI0uNTKRQHpKyrMswxDAwHGAAAyx2N0Z3+OZ/YnTkmv8lkyF4Z1uXV6PjCGVlLRzgXiw2sQ==" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="completed keyexchange" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="completed challenge" Aug 26 11:40:08 dadadac volumio[1266]: info: Initializing connection to go-librespot Websocket Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=debug msg="new websocket client" Aug 26 11:40:08 dadadac volumio[1266]: info: Connection to go-librespot Websocket established Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=info msg="authenticated AP" username="mi*******73" Aug 26 11:40:08 dadadac go-librespot[7053]: time="2026-08-26T11:40:08+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 26 11:40:08 dadadac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 26 11:40:08 dadadac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 26 11:40:08 dadadac volumio[1266]: info: Connection to go-librespot Websocket closed Aug 26 11:40:11 dadadac volumio[1266]: info: Getting Spotify volume Aug 26 11:40:11 dadadac volumio[1266]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 11:40:11 dadadac volumio[1266]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 26 11:40:11 dadadac volumio[1266]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 26 11:40:11 dadadac volumio[1266]: errno: -111, Aug 26 11:40:11 dadadac volumio[1266]: code: 'ECONNREFUSED', Aug 26 11:40:11 dadadac volumio[1266]: syscall: 'connect', Aug 26 11:40:11 dadadac volumio[1266]: address: '127.0.0.1', Aug 26 11:40:11 dadadac volumio[1266]: port: 9879, Aug 26 11:40:11 dadadac volumio[1266]: response: undefined Aug 26 11:40:11 dadadac volumio[1266]: } Aug 26 11:40:11 dadadac volumio[1266]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 11:40:11 dadadac sudo[7076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-26 11:39' Aug 26 11:40:11 dadadac sudo[7076]: 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"