Feb 26 02:42:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:00 volumio volumio[1654424]: info: Remote SSH Stopped Feb 26 02:42:00 volumio volumio[1654424]: error: Cannot start Volumio Streaming Daemon Feb 26 02:42:00 volumio volumio[1654424]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 26 02:42:00 volumio volumio[1654424]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 26 02:42:00 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:00 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:01 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Feb 26 02:42:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:03 volumio go-librespot[1655524]: go-librespot daemon starting... Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=debug msg="app state loaded" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:42:04 volumio go-librespot[1655526]: time="2026-02-26T02:42:04+07:00" level=info msg="zeroconf server listening on port 34603" Feb 26 02:42:05 volumio go-librespot[1655526]: time="2026-02-26T02:42:05+07:00" level=debug msg="obtained new client token: AABe6MBZnyr7FdtALwIxRypPjs2CnLoR0lqi2iQYVQVuEjaBzIlrr7Ann0a9UA4nkAWPpOAf8vPlz4dINCMZ6+/Froimo63bhQv0F37aE8dCSLncPMyjxvvcxfjhOwfJy0tIP2oN0mxkQpj0O5NXvsOfG5Aj18vrTYiJralyrZ1gMFK8a0ONZVm6AHEMlV1qH3z+XmY8h8xucCqBBLNIERmEbngaLXmfD6FpZ0dUtqZlYAHeAfLEwPdaA1k=" Feb 26 02:42:05 volumio go-librespot[1655526]: time="2026-02-26T02:42:05+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:05 volumio go-librespot[1655526]: time="2026-02-26T02:42:05+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:05 volumio go-librespot[1655526]: time="2026-02-26T02:42:05+07:00" level=debug msg="completed challenge" Feb 26 02:42:05 volumio go-librespot[1655526]: time="2026-02-26T02:42:05+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:05 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:09 volumio volumio[1654424]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 02:42:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Feb 26 02:42:09 volumio volumio[1654424]: info: camilladsp respawn in 1600 ms (attempt 5/10) Feb 26 02:42:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:09 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:10 volumio go-librespot[1655544]: go-librespot daemon starting... Feb 26 02:42:10 volumio go-librespot[1655545]: time="2026-02-26T02:42:10+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:10 volumio go-librespot[1655545]: time="2026-02-26T02:42:10+07:00" level=debug msg="app state loaded" Feb 26 02:42:10 volumio go-librespot[1655545]: time="2026-02-26T02:42:10+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=info msg="zeroconf server listening on port 46325" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=debug msg="obtained new client token: AAAd9R7no3jCkzgfsy9fiXUhw+YNjo8VHl5wExNGiwftHCh3Z0oh4hVcVii4bDlMA8zdmv5gfL4QNiWn6KxQrIqKsXP10Zhbq7+GkxUxCGxDxlE5PNMbf3/jM5v6ixzkEfvFvcLVVbUEp0E2xYuu9k2Zi9/AqsMfD1t8HvcWZblvAw2FW6EawZMiVGBBUQhFoJbhn0SujXFIPDDNCeBz3Xc2nUdIxUXiu1KMI83PUoKsMazavuJwXmxvrl8=" Feb 26 02:42:11 volumio go-librespot[1655545]: time="2026-02-26T02:42:11+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:13 volumio go-librespot[1655545]: time="2026-02-26T02:42:13+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:13 volumio go-librespot[1655545]: time="2026-02-26T02:42:13+07:00" level=debug msg="completed challenge" Feb 26 02:42:13 volumio go-librespot[1655545]: time="2026-02-26T02:42:13+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:13 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:13 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:13 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:13 volumio volumio[1654424]: info: MYVOLUMIO: Adding device Feb 26 02:42:13 volumio volumio[1654424]: info: MYVOLUMIO: Evaluating Server Feb 26 02:42:15 volumio volumio[1654424]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 02:42:16 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:16 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Feb 26 02:42:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:17 volumio go-librespot[1655585]: go-librespot daemon starting... Feb 26 02:42:17 volumio go-librespot[1655594]: time="2026-02-26T02:42:17+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:17 volumio go-librespot[1655594]: time="2026-02-26T02:42:17+07:00" level=debug msg="app state loaded" Feb 26 02:42:17 volumio go-librespot[1655594]: time="2026-02-26T02:42:17+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:17 volumio systemd[1]: mpd.service: start operation timed out. Terminating. Feb 26 02:42:17 volumio systemd[1]: mpd.service: Failed with result 'timeout'. Feb 26 02:42:17 volumio systemd[1]: Failed to start mpd.service - Music Player Daemon. Feb 26 02:42:17 volumio systemd[1]: mpd.service: Consumed 14.335s CPU time. Feb 26 02:42:17 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 26 02:42:17 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:18 volumio volumio[1654424]: info: camilladsp respawn in 3200 ms (attempt 6/10) Feb 26 02:42:18 volumio sudo[1655606]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 02:42:18 volumio sudo[1655606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 26 02:42:18 volumio sudo[1655606]: pam_unix(sudo:session): session closed for user root Feb 26 02:42:18 volumio go-librespot[1655594]: time="2026-02-26T02:42:18+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:18 volumio go-librespot[1655594]: time="2026-02-26T02:42:18+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:18 volumio go-librespot[1655594]: time="2026-02-26T02:42:18+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:18 volumio go-librespot[1655594]: time="2026-02-26T02:42:18+07:00" level=info msg="zeroconf server listening on port 38081" Feb 26 02:42:19 volumio go-librespot[1655594]: time="2026-02-26T02:42:19+07:00" level=debug msg="obtained new client token: AAADhYt2zuyG/JFH7j+KF1JT0yKg3BJees1Owps3e04egcf5Ih3DmvP4pJyNRAfkm2JyGwDhgh/h3Gn60tbgMtRek8Cy5ZLhnwqPPCuWVql13bQoAp5Zch51bWuJ3vZQBxWAtnU3d1PB97rsS2betATGqg6oKPiVRBFTVRgUHZAUZKNlSYhXculXPKasdad2jBQJRRV4h3llL1yjN6SFfMBPIm/9DFi4s7kIK+hsLke2wN7FqN8oE2uk" Feb 26 02:42:19 volumio go-librespot[1655594]: time="2026-02-26T02:42:19+07:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Feb 26 02:42:19 volumio go-librespot[1655594]: time="2026-02-26T02:42:19+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:42:19 volumio go-librespot[1655594]: time="2026-02-26T02:42:19+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:19 volumio go-librespot[1655594]: time="2026-02-26T02:42:19+07:00" level=debug msg="completed challenge" Feb 26 02:42:20 volumio go-librespot[1655594]: time="2026-02-26T02:42:20+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:21 volumio volumio[1654424]: info: Setting Geolocation for MyVolumio to as1 Feb 26 02:42:21 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:21 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:21 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:23 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Feb 26 02:42:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:23 volumio go-librespot[1655628]: go-librespot daemon starting... Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=debug msg="app state loaded" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=info msg="zeroconf server listening on port 39919" Feb 26 02:42:24 volumio go-librespot[1655629]: time="2026-02-26T02:42:24+07:00" level=debug msg="obtained new client token: AAA9CaGPYsw2/vIatA3kCeAQqTXVSQSS3IndhwGEaT+9/qxkhJg882g2u91UAyze/6zVJO3d4MAGII4eR2VtnzDlhG599auAX0F5F38v4eait5ezqKt5AdxPn/ImmwvUowRkyQ/Xnqm5zi8Vl5A+dUvx890fvOcIjDilztAGmq6PmnBKaAiIpdo7qiVRaaEuBrJFQmsP/xNCrJijvVmuw+kH+/BN1aTr0ZnyQAHb6J8cwgKQ9SvXs2BlInk=" Feb 26 02:42:25 volumio go-librespot[1655629]: time="2026-02-26T02:42:25+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:25 volumio go-librespot[1655629]: time="2026-02-26T02:42:25+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:25 volumio go-librespot[1655629]: time="2026-02-26T02:42:25+07:00" level=debug msg="completed challenge" Feb 26 02:42:25 volumio go-librespot[1655629]: time="2026-02-26T02:42:25+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:25 volumio volumio[1654424]: info: Listing playlists Feb 26 02:42:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:26 volumio volumio[1654424]: info: Listing playlists Feb 26 02:42:28 volumio volumio[1654424]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 02:42:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Feb 26 02:42:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:29 volumio volumio[1654424]: info: Updating MyVolumio device info Feb 26 02:42:29 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:29 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:29 volumio volumio[1654424]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:42:30 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:30 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:30 volumio go-librespot[1655647]: go-librespot daemon starting... Feb 26 02:42:30 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:30 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=debug msg="app state loaded" Feb 26 02:42:30 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:30 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:30+07:00" level=info msg="zeroconf server listening on port 38627" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:31+07:00" level=debug msg="obtained new client token: AABvbJxCG4m8qpbz27hbQJWD05ScUWzF2zF4XLIrvJv6m990/dQl8EZc5FGsdRyodU4Lv6mYzIJtgBuywGr2/qrcwCAJ5I3keL4C99KXGaSxY7BZSY2Hi+dYtEUU6REpenZkExI3ImIzww7Au3mYw4RACyOIQxCgxOaRnuCUvNKCztqy1ILY/5RhjidhtHiNxSoPOfFBqfZF72FqI0p+SoGnXpbm54QP902WDihtAR4v0YP+nsx80QIU" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:31+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:31+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:31 volumio go-librespot[1655649]: time="2026-02-26T02:42:31+07:00" level=debug msg="completed challenge" Feb 26 02:42:32 volumio go-librespot[1655649]: time="2026-02-26T02:42:32+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:32 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:33 volumio volumio[1654424]: info: camilladsp respawn in 6400 ms (attempt 7/10) Feb 26 02:42:33 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:33 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34. Feb 26 02:42:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:35 volumio go-librespot[1655673]: go-librespot daemon starting... Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=debug msg="app state loaded" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=info msg="zeroconf server listening on port 44843" Feb 26 02:42:36 volumio go-librespot[1655675]: time="2026-02-26T02:42:36+07:00" level=debug msg="obtained new client token: AACyPbQx02sd09t+8AmthlrNH/aEniOAcmvJ6PKKgotGygsRnE+lW660Pntjv7TZz1kjFFhX+lJ0FuL/EiViw3t1Z9TLUQbtJnrPe9nL9nsbWgC6ZKrRRDkEiUV3G3VKy6CiOzou7sQZqn5rDm2S2qgCX9bOE7hJCml0UmNc/fdXIBdo9DJ/fYrLMa4rvUEICQ9uoPWzR3hI838X/HdiimzDUxT2FMOHi4S1OvsXk+xEHlUv1Ic0scZQWa0=" Feb 26 02:42:37 volumio go-librespot[1655675]: time="2026-02-26T02:42:37+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:37 volumio go-librespot[1655675]: time="2026-02-26T02:42:37+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:37 volumio go-librespot[1655675]: time="2026-02-26T02:42:37+07:00" level=debug msg="completed challenge" Feb 26 02:42:37 volumio go-librespot[1655675]: time="2026-02-26T02:42:37+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:37 volumio volumio[1654424]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 02:42:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:37 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:38 volumio volumio[1654424]: info: Listing playlists Feb 26 02:42:38 volumio volumio[1654424]: info: Listing playlists Feb 26 02:42:38 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:40 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:40 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35. Feb 26 02:42:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:41 volumio volumio[1654424]: info: camilladsp respawn in 10000 ms (attempt 8/10) Feb 26 02:42:41 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:41 volumio go-librespot[1655692]: go-librespot daemon starting... Feb 26 02:42:41 volumio go-librespot[1655693]: time="2026-02-26T02:42:41+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:41 volumio go-librespot[1655693]: time="2026-02-26T02:42:41+07:00" level=debug msg="app state loaded" Feb 26 02:42:41 volumio go-librespot[1655693]: time="2026-02-26T02:42:41+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:42 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:42 volumio go-librespot[1655693]: time="2026-02-26T02:42:42+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:42 volumio go-librespot[1655693]: time="2026-02-26T02:42:42+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:42 volumio go-librespot[1655693]: time="2026-02-26T02:42:42+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:42 volumio go-librespot[1655693]: time="2026-02-26T02:42:42+07:00" level=info msg="zeroconf server listening on port 37265" Feb 26 02:42:43 volumio go-librespot[1655693]: time="2026-02-26T02:42:43+07:00" level=debug msg="obtained new client token: AACLnOgt0pAC/uqHnd6ea7rs607uM267W5UBHINcU/N48IExqVwfZMSprJ4H7gQI6tbioz1UuAw246M4qYKLSvjep1S2DxGfJlVYv/5qRLuhd8ouBl53pGQ+WXZCZgZ0kF+WGf0Z6oPFWieITQlagmisw9F6Ny887csAkEH+G+MTFZtLy5t8wVMayHwfDtT31X+RHi2YbauccK/fq38AHxjxdCNz+8mij00TdNllgHhdU+O92ZqN/6J/5C8=" Feb 26 02:42:43 volumio go-librespot[1655693]: time="2026-02-26T02:42:43+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:43 volumio go-librespot[1655693]: time="2026-02-26T02:42:43+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:43 volumio go-librespot[1655693]: time="2026-02-26T02:42:43+07:00" level=debug msg="completed challenge" Feb 26 02:42:43 volumio go-librespot[1655693]: time="2026-02-26T02:42:43+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:44 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:44 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:45 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:45 volumio volumio[1654424]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36. Feb 26 02:42:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:47 volumio go-librespot[1655720]: go-librespot daemon starting... Feb 26 02:42:47 volumio go-librespot[1655721]: time="2026-02-26T02:42:47+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:47 volumio go-librespot[1655721]: time="2026-02-26T02:42:47+07:00" level=debug msg="app state loaded" Feb 26 02:42:47 volumio go-librespot[1655721]: time="2026-02-26T02:42:47+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:48 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:48 volumio go-librespot[1655721]: time="2026-02-26T02:42:48+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:48 volumio go-librespot[1655721]: time="2026-02-26T02:42:48+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:48 volumio go-librespot[1655721]: time="2026-02-26T02:42:48+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:48 volumio go-librespot[1655721]: time="2026-02-26T02:42:48+07:00" level=info msg="zeroconf server listening on port 43057" Feb 26 02:42:48 volumio go-librespot[1655721]: time="2026-02-26T02:42:48+07:00" level=debug msg="obtained new client token: AACaaW2gtqpbmKekTJ6WNYVETCdpyuLkI0M+e7qn10dLCQvYXTYblw9mNqEXhbakVxNJPYLJMWpJl8oqsr4A2cnJez8ccDyQo5qZYHK182vrTOhlSKXHlG1wsrkLnVvcUimO+KVZb8dzBUL4ALUUSIRffY0UTn8WZVl0kXLjpEffoaOX6kM0ZCSoRJ1FR38kttO4AubGsRWI/aJbgQmSIhqm4u15V3TYh9KmdE4EcTeJtl3kU5Z3dfDRmxg=" Feb 26 02:42:49 volumio go-librespot[1655721]: time="2026-02-26T02:42:49+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:49 volumio go-librespot[1655721]: time="2026-02-26T02:42:49+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:49 volumio go-librespot[1655721]: time="2026-02-26T02:42:49+07:00" level=debug msg="completed challenge" Feb 26 02:42:49 volumio go-librespot[1655721]: time="2026-02-26T02:42:49+07:00" level=debug msg="new websocket client" Feb 26 02:42:49 volumio go-librespot[1655721]: time="2026-02-26T02:42:49+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:49 volumio volumio[1654424]: info: Connection to go-librespot Websocket established Feb 26 02:42:50 volumio volumio[1654424]: info: Connection to go-librespot Websocket closed Feb 26 02:42:50 volumio volumio[1654424]: info: CoreCommandRouter::volumioGetState Feb 26 02:42:50 volumio volumio[1654424]: info: CorePlayQueue::getTrack 0 Feb 26 02:42:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37. Feb 26 02:42:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:54 volumio go-librespot[1655753]: go-librespot daemon starting... Feb 26 02:42:54 volumio go-librespot[1655756]: time="2026-02-26T02:42:54+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:42:54 volumio go-librespot[1655756]: time="2026-02-26T02:42:54+07:00" level=debug msg="app state loaded" Feb 26 02:42:54 volumio go-librespot[1655756]: time="2026-02-26T02:42:54+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=info msg="zeroconf server listening on port 36305" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=debug msg="obtained new client token: AABRbACTK6iayOZNkvuNsvhwyPVoP0q4lbrCnO4AA9uHZP+DnGz16b+r8uWpyqi9Flr8FyyMrnHrnc6Z0hLNXwJDMuRyzcN0koqcQrq5XE3Z5S9BS8gy10cCG+EPhSDgpBYzDzpXGRfOXU3q0f2zg3oYBCF2MzXn+JvY6HWqmYoDNjWy6eWS9uYVHcRvLR0QTgZInmGAVgjViFJP6V8eCTw52eZnJS9RVgo+o0DUXghMFeim6VLIrT7hO9Y=" Feb 26 02:42:55 volumio go-librespot[1655756]: time="2026-02-26T02:42:55+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:42:55 volumio volumio[1654424]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 26 02:42:56 volumio go-librespot[1655756]: time="2026-02-26T02:42:56+07:00" level=debug msg="completed keyexchange" Feb 26 02:42:56 volumio go-librespot[1655756]: time="2026-02-26T02:42:56+07:00" level=debug msg="completed challenge" Feb 26 02:42:56 volumio go-librespot[1655756]: time="2026-02-26T02:42:56+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:42:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:42:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:42:57 volumio volumio[1654424]: info: Getting Spotify volume Feb 26 02:42:57 volumio volumio[1654424]: info: Initializing connection to go-librespot Websocket Feb 26 02:42:58 volumio volumio[1654424]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:42:58 volumio volumio[1654424]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:42:58 volumio volumio[1654424]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 26 02:42:58 volumio volumio[1654424]: errno: -111, Feb 26 02:42:58 volumio volumio[1654424]: code: 'ECONNREFUSED', Feb 26 02:42:58 volumio volumio[1654424]: syscall: 'connect', Feb 26 02:42:58 volumio volumio[1654424]: address: '127.0.0.1', Feb 26 02:42:58 volumio volumio[1654424]: port: 9879, Feb 26 02:42:58 volumio volumio[1654424]: response: undefined Feb 26 02:42:58 volumio volumio[1654424]: } Feb 26 02:42:58 volumio volumio[1654424]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:42:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38. Feb 26 02:42:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:42:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:00 volumio go-librespot[1655778]: go-librespot daemon starting... Feb 26 02:43:00 volumio go-librespot[1655779]: time="2026-02-26T02:43:00+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:00 volumio go-librespot[1655779]: time="2026-02-26T02:43:00+07:00" level=debug msg="app state loaded" Feb 26 02:43:00 volumio go-librespot[1655779]: time="2026-02-26T02:43:00+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=info msg="zeroconf server listening on port 38589" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="obtained new client token: AABI1+F65OAcw9rennb22/SoQ6DpU9UjqPPmucG0tzYm8+xLTyBn0DCVrye0REGVpC3FY/EBR1V/IpFNAWttnkjeOVc2ansgM8XgFwfQeiGLepTUW6AmbxYMQjk6pBfVmfdDcevpY0uEGjBGZQFT74kURb4wi/Cy0khANZyNNXVWn8Gb8h6FadXZm/u8za63n6m03NDf4p+pNkYwAbGO7icVRNwvackgFdaOotTPTmgyogiYxa9GUIsQtOc=" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=debug msg="completed challenge" Feb 26 02:43:01 volumio go-librespot[1655779]: time="2026-02-26T02:43:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39. Feb 26 02:43:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:06 volumio go-librespot[1655804]: go-librespot daemon starting... Feb 26 02:43:07 volumio go-librespot[1655806]: time="2026-02-26T02:43:07+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:07 volumio go-librespot[1655806]: time="2026-02-26T02:43:07+07:00" level=debug msg="app state loaded" Feb 26 02:43:07 volumio go-librespot[1655806]: time="2026-02-26T02:43:07+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:08 volumio go-librespot[1655806]: time="2026-02-26T02:43:08+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:43:08 volumio go-librespot[1655806]: time="2026-02-26T02:43:08+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:43:08 volumio go-librespot[1655806]: time="2026-02-26T02:43:08+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:43:08 volumio go-librespot[1655806]: time="2026-02-26T02:43:08+07:00" level=info msg="zeroconf server listening on port 45263" Feb 26 02:43:09 volumio go-librespot[1655806]: time="2026-02-26T02:43:09+07:00" level=debug msg="obtained new client token: AACYRTw2V9j9gUa3e/ZKI6RkJYGBli88MygC9Ois9wEmbUxH7O+hGLYFe9WqjOUri+r9jacDHLmHyl9JR1L1JgqcXcefd+xzATOYW+ovFws1FXDMnsIZAroyJZfrktJb4nz2ELeHQNFRRI+KAsQEjsDObaMbn8zSn51QKwaqLT2rGq1mmydhZkOM5muli6MdmJn7MZHcILWELzZj3NAZeaOSu7eXzPxIISOtWKmPDMFegHakdeCWBUdm" Feb 26 02:43:09 volumio go-librespot[1655806]: time="2026-02-26T02:43:09+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:43:09 volumio go-librespot[1655806]: time="2026-02-26T02:43:09+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:09 volumio go-librespot[1655806]: time="2026-02-26T02:43:09+07:00" level=debug msg="completed challenge" Feb 26 02:43:09 volumio go-librespot[1655806]: time="2026-02-26T02:43:09+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40. Feb 26 02:43:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:14 volumio go-librespot[1655831]: go-librespot daemon starting... Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=debug msg="app state loaded" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:43:15 volumio go-librespot[1655835]: time="2026-02-26T02:43:15+07:00" level=info msg="zeroconf server listening on port 43295" Feb 26 02:43:16 volumio go-librespot[1655835]: time="2026-02-26T02:43:16+07:00" level=debug msg="obtained new client token: AABIZWq2Xjsm01SC+PepuPhxw4ooBtv0Wr5Qv9Hrs7V1J78OEj6dPMjiij6laXPqhApEhOanX3423s/3a47Ke9OR234Fyec8deSJWfesYtwUNeH52SSIldFHwBrPTbS2PSX1k3mshjh21+Gdvy4XcGAqHUeXWMR8p1UE3iQB5k1MbcKhHH4eaiReRX9Jb7wg4xy0cXdydUmuBKqGU2z3gP27NLG5DIMpbgCE3bVLZvCX1IxinfxIptjz" Feb 26 02:43:16 volumio go-librespot[1655835]: time="2026-02-26T02:43:16+07:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Feb 26 02:43:16 volumio go-librespot[1655835]: time="2026-02-26T02:43:16+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:43:16 volumio go-librespot[1655835]: time="2026-02-26T02:43:16+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:16 volumio go-librespot[1655835]: time="2026-02-26T02:43:16+07:00" level=debug msg="completed challenge" Feb 26 02:43:17 volumio go-librespot[1655835]: time="2026-02-26T02:43:17+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41. Feb 26 02:43:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:21 volumio go-librespot[1655845]: go-librespot daemon starting... Feb 26 02:43:21 volumio go-librespot[1655846]: time="2026-02-26T02:43:21+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:21 volumio go-librespot[1655846]: time="2026-02-26T02:43:21+07:00" level=debug msg="app state loaded" Feb 26 02:43:21 volumio go-librespot[1655846]: time="2026-02-26T02:43:21+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=info msg="zeroconf server listening on port 44813" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=debug msg="obtained new client token: AABB8QE5IFkRefgo7xYU9Lutew9yFYeBN9fbJs1M9E5Oak5P0arbqKGt5EVuQTvX8mJRRRneGYXHqP2L1UX/Tg3lcOsQxep//60inY2RstEhdVJ92Pg6tObvCWC6/E9cblclpdu+7QAyUc/gWyllquBpjh1kIV4vG+cjOufJhUa2uhHKG6js9+RhwAflCMEuStw1pdzZ+nqupatgzVGLZGy5BXD03upCxqLfgxIf8G1ghgqVk+iMM8kT7GU=" Feb 26 02:43:23 volumio go-librespot[1655846]: time="2026-02-26T02:43:23+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:43:24 volumio go-librespot[1655846]: time="2026-02-26T02:43:24+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:24 volumio go-librespot[1655846]: time="2026-02-26T02:43:24+07:00" level=debug msg="completed challenge" Feb 26 02:43:24 volumio go-librespot[1655846]: time="2026-02-26T02:43:24+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42. Feb 26 02:43:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:28 volumio go-librespot[1655871]: go-librespot daemon starting... Feb 26 02:43:28 volumio go-librespot[1655872]: time="2026-02-26T02:43:28+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:28 volumio go-librespot[1655872]: time="2026-02-26T02:43:28+07:00" level=debug msg="app state loaded" Feb 26 02:43:28 volumio go-librespot[1655872]: time="2026-02-26T02:43:28+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=info msg="zeroconf server listening on port 42049" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=debug msg="obtained new client token: AACf4+PCzsfzNm8zxX4Wu7TrYQhsdwG6vSBjy3i04TU9nErNeDSpShR5oVXj4mYt+6EcGxztHTG3IaRJXiPNGvV+b17OL9aV7ErSvgA0ckBtJC14zstNglauEdxhgqZcB6LkyTevTRShCU34CfeAwHD7cP039RWwZWmu99Nq7wzhBp0UEHB6ncEu0loaSR8lsYZ78lJVAHKpSf4r6tOB9e8gsIugyx1eIAPhlSXe7dhfvDMLRyIhYKKtsBc=" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Feb 26 02:43:29 volumio go-librespot[1655872]: time="2026-02-26T02:43:29+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:43:30 volumio go-librespot[1655872]: time="2026-02-26T02:43:30+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:30 volumio go-librespot[1655872]: time="2026-02-26T02:43:30+07:00" level=debug msg="completed challenge" Feb 26 02:43:30 volumio go-librespot[1655872]: time="2026-02-26T02:43:30+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43. Feb 26 02:43:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:43:35 volumio go-librespot[1655887]: go-librespot daemon starting... Feb 26 02:43:35 volumio go-librespot[1655896]: time="2026-02-26T02:43:35+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:43:35 volumio go-librespot[1655896]: time="2026-02-26T02:43:35+07:00" level=debug msg="app state loaded" Feb 26 02:43:35 volumio go-librespot[1655896]: time="2026-02-26T02:43:35+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=info msg="zeroconf server listening on port 36909" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="obtained new client token: AACtokX1gO23zJo1a7mKlXLBYdeatj7nmNVQfGyedns0sXunbfxHvduJPcsQDL8SASPAAa7L8o2nh8U6yOijtAws0NOHUxslCYhGIVve9Qi2Wy7t7Sf/3NmioG0wwUfPxwpEPV3M9A+x3BfwGVL5M02Qz5srpYxAoOcG/1slo3Gop5/QNG8dHcF/WwZWcqDH4eIjVl4D9WoDMES5fjOoojeTZ7y9c67sHSuvCvmmgypzsuKjU8Zz8acDTnw=" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="completed keyexchange" Feb 26 02:43:37 volumio go-librespot[1655896]: time="2026-02-26T02:43:37+07:00" level=debug msg="completed challenge" Feb 26 02:43:38 volumio go-librespot[1655896]: time="2026-02-26T02:43:38+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:43:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:43:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:43:40 volumio sudo[1655910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 02:42' Feb 26 02:43:40 volumio sudo[1655910]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"