Oct 11 22:29:45 volumio go-librespot[135219]: time="2026-10-11T22:29:45-07:00" level=fatal msg="daemon exited with error" error="failed exchanging device code: context deadline exceeded" Oct 11 22:29:45 volumio volumio[1269]: error: Failed to get Spotify volume from local API: Error: socket hang up Oct 11 22:29:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 11 22:29:45 volumio volumio[1269]: info: Connection to go-librespot Websocket closed Oct 11 22:29:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 11 22:29:45 volumio systemd[1]: go-librespot-daemon.service: Consumed 1.621s CPU time. Oct 11 22:29:48 volumio volumio[1269]: info: Initializing connection to go-librespot Websocket Oct 11 22:29:48 volumio volumio[1269]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 11 22:29:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Oct 11 22:29:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 11 22:29:48 volumio systemd[1]: go-librespot-daemon.service: Consumed 1.621s CPU time. Oct 11 22:29:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 11 22:29:48 volumio go-librespot[144281]: go-librespot daemon starting... Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=info msg="running go-librespot 0.9.1" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="app state loaded" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="stored credentials not found" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=info msg="zeroconf server listening on port 43871" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 11 22:29:48 volumio go-librespot[144282]: time="2026-10-11T22:29:48-07:00" level=debug msg="obtained new client token: AAFG2qociac/3A+etGLzA9p6luTU5CfZ0nbUcV8RkdH9RNRCAjN+yGK9PA/euCW12E9YcqtG7pUanegCWnxUujeVSjwWh5yR4Kwkhx7f/UnB4l6YjCD8s97QHxVgBWufrJ4jXTGf7pmBdd6p5gAwjOrcwyxwHdRqnRAQzoTq+fIQMG+7ItphtRYbId+vuXXd1YIADba92OR80V9pOnPF8jZaKuWNpl+qbupYXag8K4rHJB5OZnbfsbo=" Oct 11 22:29:49 volumio go-librespot[144282]: time="2026-10-11T22:29:49-07:00" level=info msg="to complete authentication visit https://spotify.com/pair?code=Z6K3Z6 and, if prompted, enter code Z6K3Z6" Oct 11 22:29:49 volumio go-librespot[144282]: time="2026-10-11T22:29:49-07:00" level=debug msg="avahi service \"Volumio\" established" Oct 11 22:29:51 volumio volumio[1269]: info: Initializing connection to go-librespot Websocket Oct 11 22:29:51 volumio go-librespot[144282]: time="2026-10-11T22:29:51-07:00" level=debug msg="new websocket client" Oct 11 22:29:51 volumio volumio[1269]: info: Connection to go-librespot Websocket established Oct 11 22:29:54 volumio volumio[1269]: info: Getting Spotify volume Oct 11 22:29:54 volumio volumio[1269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 11 22:29:54 volumio volumio[1269]: info: CoreCommandRouter::volumioGetState Oct 11 22:29:54 volumio volumio[1269]: info: CorePlayQueue::getTrack 49 Oct 11 22:29:54 volumio volumio[1269]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Oct 11 22:29:54 volumio volumio[1269]: SPOTIFY: SPOTIFY VOLUME 70 Oct 11 22:29:54 volumio volumio[1269]: SPOTIFY: VOLUMIO VOLUME 69 Oct 11 22:29:54 volumio volumio[1269]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 11 22:30:57 volumio volumio[1269]: info: [ytmusic] Refresh session PO token Oct 11 22:30:57 volumio volumio[1269]: info: [ytmusic] Obtained session PO token using visitorData (expires in 43101 seconds) Oct 11 22:30:57 volumio volumio[1269]: info: [ytmusic] Going to refresh session PO token in 43001 seconds Oct 11 22:30:57 volumio volumio[1269]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 22:30:57 volumio volumio[1269]: TypeError: Chaining cycle detected for promise # Oct 11 22:30:57 volumio volumio[1269]: at #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:128:21) Oct 11 22:30:57 volumio volumio[1269]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 11 22:30:57 volumio volumio[1269]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 22:30:57 volumio sudo[144476]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-11 22:29' Oct 11 22:30:57 volumio sudo[144476]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"