Feb 26 02:31:00 volumio volumio[1651353]: info: Received Get System Info Feb 26 02:31:00 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 26 02:31:00 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 26 02:31:00 volumio volumio[1651353]: info: Discovery: Getting this device information Feb 26 02:31:00 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:00 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:00 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 26 02:31:01 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:01 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Feb 26 02:31:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:02 volumio go-librespot[1652230]: go-librespot daemon starting... Feb 26 02:31:02 volumio go-librespot[1652231]: time="2026-02-26T02:31:02+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:02 volumio go-librespot[1652231]: time="2026-02-26T02:31:02+07:00" level=debug msg="app state loaded" Feb 26 02:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:02+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:03+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:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:03+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:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:03+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:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:03+07:00" level=info msg="zeroconf server listening on port 33047" Feb 26 02:31:03 volumio go-librespot[1652231]: time="2026-02-26T02:31:03+07:00" level=debug msg="obtained new client token: AABCIe/GHRTDnap1lMLKv5Pst19l79F5pLeHDs90CHMrWa0E5U37FB5hT1x7agxyIRr5faAf2UWCS3MrzregOvBoLAJWkz3vP90ZlyffPCsh0/f8MbOX8d7PuDsTCx2fOCUPAbLF0Ax4DYet1TcsSgIdVdgwvr9mWFDvciWvZRPfaXyZ7ioGXbO6q6wJfSTrbaa9+W9gpmo+/XxhEDYbA7xVQIMKAQ7CB9DnDgRP7b0vunFFYAugD2KoM5Y=" Feb 26 02:31:04 volumio go-librespot[1652231]: time="2026-02-26T02:31:04+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:04 volumio go-librespot[1652231]: time="2026-02-26T02:31:04+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:04 volumio go-librespot[1652231]: time="2026-02-26T02:31:04+07:00" level=debug msg="completed challenge" Feb 26 02:31:04 volumio go-librespot[1652231]: time="2026-02-26T02:31:04+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:31:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:06 volumio volumio[1651353]: info: camilladsp respawn in 100 ms (attempt 1/10) Feb 26 02:31:06 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:06 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Feb 26 02:31:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:08 volumio go-librespot[1652274]: go-librespot daemon starting... Feb 26 02:31:08 volumio go-librespot[1652275]: time="2026-02-26T02:31:08+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:08 volumio go-librespot[1652275]: time="2026-02-26T02:31:08+07:00" level=debug msg="app state loaded" Feb 26 02:31:08 volumio go-librespot[1652275]: time="2026-02-26T02:31:08+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:09 volumio go-librespot[1652275]: time="2026-02-26T02:31:09+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:31:09 volumio go-librespot[1652275]: time="2026-02-26T02:31:09+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:31:09 volumio go-librespot[1652275]: time="2026-02-26T02:31:09+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:31:10 volumio go-librespot[1652275]: time="2026-02-26T02:31:09+07:00" level=info msg="zeroconf server listening on port 33203" Feb 26 02:31:10 volumio go-librespot[1652275]: time="2026-02-26T02:31:10+07:00" level=debug msg="obtained new client token: AACeFXDMFRqSJktxxC6Ty6K380Gi6VjCuGj7E7SB6DnAI2B1mJa12syOm5nu5wfHH34e3RBdn4SVmMjwmQyERgaDOTq1FJaZH/6mCFt41gx3W6z6WcgrAras9f/KdzDKcpIo3hMUPrxk3kMmD1JLrr1D35BbeG2+Q0m250w1IGgJnOkW/vTGd2muQdIqWnKbQbkNrV3zf25fmSE08fSR/tw2jia9i1rsHKmPeoP8mdt92ZT3LfTLigRR" Feb 26 02:31:10 volumio volumio[1651353]: info: MyVolumio status changed Feb 26 02:31:10 volumio go-librespot[1652275]: time="2026-02-26T02:31:10+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:10 volumio volumio[1651353]: info: Streaming services startup Feb 26 02:31:10 volumio volumio[1651353]: info: Starting Streaming Daemon Feb 26 02:31:10 volumio go-librespot[1652275]: time="2026-02-26T02:31:10+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:10 volumio go-librespot[1652275]: time="2026-02-26T02:31:10+07:00" level=debug msg="completed challenge" Feb 26 02:31:11 volumio go-librespot[1652275]: time="2026-02-26T02:31:11+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:31:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:11 volumio sudo[1652284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 26 02:31:11 volumio sudo[1652284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:31:12 volumio volumio[1651353]: info: Removing browser output: myVolumio user plan is not superstar Feb 26 02:31:12 volumio sudo[1652284]: pam_unix(sudo:session): session closed for user root Feb 26 02:31:13 volumio volumio[1651353]: info: Removing audio output: Feb 26 02:31:13 volumio volumio[1651353]: info: Stoppping Tunnel 1 Feb 26 02:31:14 volumio sudo[1652289]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 26 02:31:14 volumio sudo[1652289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:31:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Feb 26 02:31:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:15 volumio go-librespot[1652293]: go-librespot daemon starting... Feb 26 02:31:15 volumio go-librespot[1652294]: time="2026-02-26T02:31:15+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:15 volumio go-librespot[1652294]: time="2026-02-26T02:31:15+07:00" level=debug msg="app state loaded" Feb 26 02:31:15 volumio go-librespot[1652294]: time="2026-02-26T02:31:15+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:15 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:15 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:16 volumio go-librespot[1652294]: time="2026-02-26T02:31:16+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:31:16 volumio go-librespot[1652294]: time="2026-02-26T02:31:16+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:31:16 volumio go-librespot[1652294]: time="2026-02-26T02:31:16+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:31:16 volumio go-librespot[1652294]: time="2026-02-26T02:31:16+07:00" level=info msg="zeroconf server listening on port 40911" Feb 26 02:31:16 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:16 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:16 volumio go-librespot[1652294]: time="2026-02-26T02:31:16+07:00" level=debug msg="obtained new client token: AABVF5Sn/6Ks7kr38hhHfxvX/yJgvNZXjqYzzICjRrj1mjtQ3gf21jbBY9/lz6Q312QNjuN9Co8YlGeKhsJEki/QqcqPlrFyRDHLoFnH3q8UxgtlQdBDkoSgFZk1h0qStDrM8xrGvP+AcAxbeQ1IE10dvFav93E63xTIBBX2VahjK94bWQFUbCwCEmla+Kt1WYx0oIadzjxFyRXI+kMguFOPE/gG480XlZbE/51j76046X9c1geXU+tlDTI=" Feb 26 02:31:17 volumio go-librespot[1652294]: time="2026-02-26T02:31:17+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:31:17 volumio go-librespot[1652294]: time="2026-02-26T02:31:17+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:31:17 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:17 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:31:17 volumio go-librespot[1652294]: time="2026-02-26T02:31:17+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:17 volumio go-librespot[1652294]: time="2026-02-26T02:31:17+07:00" level=debug msg="completed challenge" Feb 26 02:31:17 volumio sudo[1652289]: pam_unix(sudo:session): session closed for user root Feb 26 02:31:18 volumio go-librespot[1652294]: time="2026-02-26T02:31:18+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:31:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:19 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:31:20 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:20 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:21 volumio volumio[1651353]: info: Setting Geolocation for MyVolumio to as1 Feb 26 02:31:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Feb 26 02:31:21 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:21 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:21 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:22 volumio go-librespot[1652327]: go-librespot daemon starting... Feb 26 02:31:22 volumio volumio[1651353]: info: Listing playlists Feb 26 02:31:22 volumio volumio[1651353]: info: Listing playlists Feb 26 02:31:22 volumio go-librespot[1652328]: time="2026-02-26T02:31:22+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:22 volumio go-librespot[1652328]: time="2026-02-26T02:31:22+07:00" level=debug msg="app state loaded" Feb 26 02:31:22 volumio go-librespot[1652328]: time="2026-02-26T02:31:22+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31: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-gae2.spotify.com:80]" Feb 26 02:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31:23+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:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31:23+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:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31:23+07:00" level=info msg="zeroconf server listening on port 34531" Feb 26 02:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31:23+07:00" level=debug msg="obtained new client token: AABtlrHDsMjmVCe50ASEVbJWkneeFZW6lHtz3OT1ogiZfDNDmH10sWXs0GPKxoAcB8DFzCx5QcStNawVFbUp2XJjoxox4C1wSt0OYIWpRjUS/RoKKRDF3xXwMey7024yaBpV+9JF33/SJGZpZJo853GRfLIK3JSl1am4cvhD/GfnQJsnTpqpJp6EXns1yAmMbIAl993ELLr9rfggd+uEAYOGIR8+qUPbN9CQpWMReL1/XH5rtVRiuDpn6tQ=" Feb 26 02:31:23 volumio go-librespot[1652328]: time="2026-02-26T02:31:23+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:24 volumio go-librespot[1652328]: time="2026-02-26T02:31:24+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:24 volumio go-librespot[1652328]: time="2026-02-26T02:31:24+07:00" level=debug msg="completed challenge" Feb 26 02:31:24 volumio go-librespot[1652328]: time="2026-02-26T02:31: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:31:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:26 volumio volumio[1651353]: info: Remote SSH Stopped Feb 26 02:31:26 volumio volumio[1651353]: error: Cannot start Volumio Streaming Daemon Feb 26 02:31:26 volumio volumio[1651353]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 26 02:31:26 volumio volumio[1651353]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 26 02:31:26 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:31:27 volumio volumio[1651353]: info: Updating MyVolumio device info Feb 26 02:31:27 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:27 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:27 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Feb 26 02:31:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:27 volumio go-librespot[1652352]: go-librespot daemon starting... Feb 26 02:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+07:00" level=debug msg="app state loaded" Feb 26 02:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+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:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+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:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+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:31:28 volumio go-librespot[1652353]: time="2026-02-26T02:31:28+07:00" level=info msg="zeroconf server listening on port 40775" Feb 26 02:31:29 volumio go-librespot[1652353]: time="2026-02-26T02:31:29+07:00" level=debug msg="obtained new client token: AAAvZY+xvRmb/WhgvjP73vw168DhV1qhPPdZdu69OqqW6JJCjg/S9HoMHvlEAJKOKgfBiZR/VrtfYSBuKc4TD5TsJrqTgxnrHzVPCbzQ8MVZM4LFfx+IrMxvvVYdcxQu2teY4eO11haB8xRcrPsLB5XD5yaiJ6f+IttgsJypJ9OYgIFJlHH/utBubBQbHrHc2yZeUiKn0LvWyEokZbHgz7zbQllcgkJRTyqK9t5uGr0zZdY4K0L/RribhdY=" Feb 26 02:31:29 volumio go-librespot[1652353]: time="2026-02-26T02:31:29+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:29 volumio go-librespot[1652353]: time="2026-02-26T02:31:29+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:29 volumio go-librespot[1652353]: time="2026-02-26T02:31:29+07:00" level=debug msg="completed challenge" Feb 26 02:31:29 volumio go-librespot[1652353]: time="2026-02-26T02:31:29+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:31:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:31 volumio volumio[1651353]: info: camilladsp respawn in 200 ms (attempt 2/10) Feb 26 02:31:32 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:32 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Feb 26 02:31:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:33 volumio go-librespot[1652363]: go-librespot daemon starting... Feb 26 02:31:33 volumio go-librespot[1652364]: time="2026-02-26T02:31:33+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:33 volumio go-librespot[1652364]: time="2026-02-26T02:31:33+07:00" level=debug msg="app state loaded" Feb 26 02:31:33 volumio go-librespot[1652364]: time="2026-02-26T02:31:33+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:34 volumio go-librespot[1652364]: time="2026-02-26T02:31:34+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:31:34 volumio go-librespot[1652364]: time="2026-02-26T02:31:34+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:31:34 volumio go-librespot[1652364]: time="2026-02-26T02:31:34+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:31:34 volumio go-librespot[1652364]: time="2026-02-26T02:31:34+07:00" level=info msg="zeroconf server listening on port 38385" Feb 26 02:31:34 volumio go-librespot[1652364]: time="2026-02-26T02:31:34+07:00" level=debug msg="obtained new client token: AACIfE5pYIE575reiHb7mZMDq5kcdNXnze+0WMeZI6fLAMNw1ZXgRqKqcPpjNMBNQ7FufYk9QgYtuS82YNcodvtMZw9fjltaETYsr3p87ErKgekezKom+4KzuK0DYlYkZ+0Md6JfXBv3PQqC2/vQgk6CddzmgYy2J1txEkU934SBVY0kbKfPnnN+IkcRcmPrPtOTXmnyOBFd7hkQv1GR/x/40t8+EZ5AWZXMIWcvaOLH5/ja3QYUOb+vto8=" Feb 26 02:31:35 volumio go-librespot[1652364]: time="2026-02-26T02:31:35+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:35 volumio go-librespot[1652364]: time="2026-02-26T02:31:35+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:35 volumio go-librespot[1652364]: time="2026-02-26T02:31:35+07:00" level=debug msg="completed challenge" Feb 26 02:31:35 volumio go-librespot[1652364]: time="2026-02-26T02:31:35+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:31:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:38 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: socket hang up Feb 26 02:31:38 volumio volumio[1651353]: info: camilladsp respawn in 400 ms (attempt 3/10) Feb 26 02:31:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Feb 26 02:31:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:39 volumio go-librespot[1652396]: go-librespot daemon starting... Feb 26 02:31:39 volumio go-librespot[1652398]: time="2026-02-26T02:31:39+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:39+07:00" level=debug msg="app state loaded" Feb 26 02:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:39+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+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:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+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:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+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:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+07:00" level=info msg="zeroconf server listening on port 39661" Feb 26 02:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+07:00" level=debug msg="obtained new client token: AABCr9xVQXZrB8+zugnjDz60Fh+YGlOloCbnYUtnulYcFzfgH6clo+QZ0NrTImNLbqdgwPsUT3RChm9ASGkdxFLA2rxPR3sgUiDCBYIgoGu9UPdT2ddsIgNxmH/YXqD4yQ5/piTdW5Ebreme6div1L+ZMdcoaO3FqtQh/6ftYn1lWOVNnLbhdATCzbk0+WdW5nKVpnYKRAim0n0kAsBnLA7CQETw9QSe6ub64v3pzmtfhVB9W7lZgPIPHl0=" Feb 26 02:31:40 volumio go-librespot[1652398]: time="2026-02-26T02:31:40+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:41 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:41 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:41 volumio go-librespot[1652398]: time="2026-02-26T02:31:41+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:41 volumio go-librespot[1652398]: time="2026-02-26T02:31:41+07:00" level=debug msg="completed challenge" Feb 26 02:31:42 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:31:42 volumio volumio[1651353]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 02:31:42 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:42 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:42 volumio volumio[1651353]: info: Listing playlists Feb 26 02:31:43 volumio go-librespot[1652398]: time="2026-02-26T02:31: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:31:43 volumio volumio[1651353]: info: Listing playlists Feb 26 02:31:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:43 volumio volumio[1651353]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 02:31:44 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: socket hang up Feb 26 02:31:45 volumio volumio[1651353]: info: camilladsp respawn in 800 ms (attempt 4/10) Feb 26 02:31:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Feb 26 02:31:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:46 volumio volumio[1651353]: info: MYVOLUMIO: Adding device Feb 26 02:31:46 volumio volumio[1651353]: info: MYVOLUMIO: Evaluating Server Feb 26 02:31:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:47 volumio go-librespot[1652419]: go-librespot daemon starting... Feb 26 02:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+07:00" level=debug msg="app state loaded" Feb 26 02:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+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:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+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:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+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:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+07:00" level=info msg="zeroconf server listening on port 41847" Feb 26 02:31:47 volumio go-librespot[1652420]: time="2026-02-26T02:31:47+07:00" level=debug msg="obtained new client token: AABvlBANJyz4ggxTPFVahwDj2cp+O8fqUH22KmL7jFa+u7WU45H1wliuqi70PoO9l8PPUMUH98sjp0UPXrOEJu22DQioI9n78GIAgY2w3dAOhX9k6YFb5x2O/cS3niMMITneT7BVx9MKKmVWdc4fkR7ck6IF97t7L6ORmwkyKBShir7y7ogMI1eRg1XGwcXrBls86sW77Vybvr0zT3xqQqlmIA/S9OLdO2HT3yRv+7y0nCdZmvVvzABBC1Q=" Feb 26 02:31:48 volumio go-librespot[1652420]: time="2026-02-26T02:31:48+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:48 volumio go-librespot[1652420]: time="2026-02-26T02:31:48+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:48 volumio go-librespot[1652420]: time="2026-02-26T02:31:48+07:00" level=debug msg="completed challenge" Feb 26 02:31:48 volumio go-librespot[1652420]: time="2026-02-26T02:31:48+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:31:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:50 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:31:50 volumio volumio[1651353]: info: Setting Geolocation for MyVolumio to as1 Feb 26 02:31:50 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:50 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:50 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:50 volumio volumio[1651353]: info: camilladsp respawn in 1600 ms (attempt 5/10) Feb 26 02:31:50 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:31:51 volumio volumio[1651353]: info: Updating MyVolumio device info Feb 26 02:31:51 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:51 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:51 volumio volumio[1651353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:31:51 volumio volumio[1651353]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 02:31:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Feb 26 02:31:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:52 volumio go-librespot[1652469]: go-librespot daemon starting... Feb 26 02:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+07:00" level=debug msg="app state loaded" Feb 26 02:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+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:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+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:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+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:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+07:00" level=info msg="zeroconf server listening on port 34497" Feb 26 02:31:52 volumio go-librespot[1652470]: time="2026-02-26T02:31:52+07:00" level=debug msg="obtained new client token: AAD1f/VC/F7uU5vXqQksmjTXPCW6P8rFE5mqLUszPb1hXdZlCQxY0wZ1FUGI4pSlQ/LNlOZ5O9QelbFRfSd2YA+VoP0fW5yXiZhn5kgSvKmFzM/gGGF4XUv31oNfAETATXQRggCWbdnSCbI45jHhM/vwdUgpubQHcn/tB2CruGoBld+V+2J8JFYzRtJsn5mr6m+8zjC9iz+8gsri4xCcQKNhbzab9KXgq0+abRYe9IgGe5JHobuQ8G1MMIw=" Feb 26 02:31:53 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:53 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:53 volumio go-librespot[1652470]: time="2026-02-26T02:31:53+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:53 volumio volumio[1651353]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 02:31:53 volumio volumio[1651353]: info: camilladsp respawn in 3200 ms (attempt 6/10) Feb 26 02:31:53 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:31:53 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:31:53 volumio go-librespot[1652470]: time="2026-02-26T02:31:53+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:53 volumio go-librespot[1652470]: time="2026-02-26T02:31:53+07:00" level=debug msg="completed challenge" Feb 26 02:31:53 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:31:53 volumio go-librespot[1652470]: time="2026-02-26T02:31:53+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:31:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:53 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:31:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Feb 26 02:31:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:31:57 volumio go-librespot[1652490]: go-librespot daemon starting... Feb 26 02:31:57 volumio go-librespot[1652491]: time="2026-02-26T02:31:57+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:31:57 volumio go-librespot[1652491]: time="2026-02-26T02:31:57+07:00" level=debug msg="app state loaded" Feb 26 02:31:57 volumio go-librespot[1652491]: time="2026-02-26T02:31:57+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+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:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+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:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+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:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+07:00" level=info msg="zeroconf server listening on port 37481" Feb 26 02:31:58 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+07:00" level=debug msg="obtained new client token: AAB3si5cekVhtZelXnPUHlQmI9vNCPsr8ztxEtN3zGxwwUd+7iWyvMLm6E/shAqrSPtQ6+aSaSSVXEaM1tiAJlOxrKqRw5dfI5260+FOMRfb8p6FN7srM6QfBFiQsF12Fa4/Wln3UPx1dIwSzEsmPhF4NPdCop6AS5SZu1cZ4v/lHK/NilH5S8mKu13ORxohPpGqmXMSiaczYIkQF3zvf63XzdA7NjZceGUh70XFPZdXgfa599jgnu7nhQs=" Feb 26 02:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+07:00" level=debug msg="completed keyexchange" Feb 26 02:31:58 volumio go-librespot[1652491]: time="2026-02-26T02:31:58+07:00" level=debug msg="completed challenge" Feb 26 02:31:59 volumio go-librespot[1652491]: time="2026-02-26T02:31:59+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 26 02:31:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:31:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:31:59 volumio volumio[1651353]: info: camilladsp respawn in 6400 ms (attempt 7/10) Feb 26 02:31:59 volumio volumio[1651353]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:32:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Feb 26 02:32:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:32:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:32:02 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:32:03 volumio go-librespot[1652523]: go-librespot daemon starting... Feb 26 02:32:03 volumio go-librespot[1652524]: time="2026-02-26T02:32:03+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:32:03 volumio go-librespot[1652524]: time="2026-02-26T02:32:03+07:00" level=debug msg="app state loaded" Feb 26 02:32:03 volumio go-librespot[1652524]: time="2026-02-26T02:32:03+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32:04+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:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32:04+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:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32:04+07:00" level=info msg="zeroconf server listening on port 38809" Feb 26 02:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32:04+07:00" level=debug msg="obtained new client token: AAD41/PQebYVsJAM62m9IE9GA3AZagZAEBGbE0lMaR57lqV+PMv5/SI2dpSVV8SUlbSFn5ml0nhOFs4COXYud5DiOg6I6EWw7wq7wx0i6c44CWZAFj1kKmqXWLpAYjP4MyzD0YUSnVFpvzOxbQkC8Xu04qKZpqZ600eogDi9yaNi16Wbm4BTbC/p7P/R53wSUK6Eiv1pQNmuQxIf27IaTAiUedB5akp1tFlZsT/zJw9rQjnhqd0er8psbPE=" Feb 26 02:32:04 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:32:04 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:32:04 volumio go-librespot[1652524]: time="2026-02-26T02:32:04+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:32:05 volumio go-librespot[1652524]: time="2026-02-26T02:32:05+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:32:05 volumio go-librespot[1652524]: time="2026-02-26T02:32:05+07:00" level=debug msg="new websocket client" Feb 26 02:32:05 volumio go-librespot[1652524]: time="2026-02-26T02:32:05+07:00" level=debug msg="completed keyexchange" Feb 26 02:32:05 volumio go-librespot[1652524]: time="2026-02-26T02:32:05+07:00" level=debug msg="completed challenge" Feb 26 02:32:05 volumio go-librespot[1652524]: time="2026-02-26T02:32: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:32:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:32:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:32:06 volumio volumio[1651353]: info: Connection to go-librespot Websocket established Feb 26 02:32:06 volumio volumio[1651353]: info: CoreCommandRouter::volumioGetState Feb 26 02:32:06 volumio volumio[1651353]: info: CorePlayQueue::getTrack 0 Feb 26 02:32:07 volumio volumio[1651353]: info: Connection to go-librespot Websocket closed Feb 26 02:32:07 volumio volumio[1651353]: info: Listing playlists Feb 26 02:32:07 volumio volumio[1651353]: info: Listing playlists Feb 26 02:32:07 volumio volumio[1651353]: info: camilladsp respawn in 10000 ms (attempt 8/10) Feb 26 02:32:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Feb 26 02:32:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:32:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:32:09 volumio go-librespot[1652556]: go-librespot daemon starting... Feb 26 02:32:09 volumio go-librespot[1652557]: time="2026-02-26T02:32:09+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:32:09 volumio go-librespot[1652557]: time="2026-02-26T02:32:09+07:00" level=debug msg="app state loaded" Feb 26 02:32:09 volumio go-librespot[1652557]: time="2026-02-26T02:32:09+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:32:10 volumio volumio[1651353]: info: Getting Spotify volume Feb 26 02:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+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:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+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:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+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:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+07:00" level=info msg="zeroconf server listening on port 35565" Feb 26 02:32:10 volumio volumio[1651353]: info: Initializing connection to go-librespot Websocket Feb 26 02:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+07:00" level=debug msg="obtained new client token: AAClb95enuUy3s/j3FAVMvPHxwM4fqGSX/vw/B/0o+YIZvGHXr5fkon3goAuwbzTDS3Hb8PdzMB1k5+G3nfDXLFn4JU9bWQhdP0K3ggOnL7iqLNzVjbncjBKENyvdDLMUUh+phK0JdZLilhmxqpK39PnD378xYi8bqVVSrPQheg+ilXnOsctq9WoUbpZU510Z3AvF9sJp/kf8gIX5sitQqBUDmXAbLqERJ/wSwxfrOqI0AVyatVr5lPTzZs=" Feb 26 02:32:10 volumio go-librespot[1652557]: time="2026-02-26T02:32:10+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:32:11 volumio go-librespot[1652557]: time="2026-02-26T02:32:11+07:00" level=debug msg="completed keyexchange" Feb 26 02:32:11 volumio go-librespot[1652557]: time="2026-02-26T02:32:11+07:00" level=debug msg="completed challenge" Feb 26 02:32:11 volumio go-librespot[1652557]: time="2026-02-26T02:32:11+07:00" level=debug msg="new websocket client" Feb 26 02:32:11 volumio go-librespot[1652557]: time="2026-02-26T02:32:11+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:32:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:32:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:32:11 volumio volumio[1651353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 26 02:32:11 volumio volumio[1651353]: info: Connection to go-librespot Websocket established Feb 26 02:32:12 volumio volumio[1651353]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:32:12 volumio volumio[1651353]: Error: socket hang up Feb 26 02:32:12 volumio volumio[1651353]: at connResetException (node:internal/errors:720:14) Feb 26 02:32:12 volumio volumio[1651353]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 26 02:32:12 volumio volumio[1651353]: at Socket.emit (node:events:526:35) Feb 26 02:32:12 volumio volumio[1651353]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 26 02:32:12 volumio volumio[1651353]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 26 02:32:12 volumio volumio[1651353]: code: 'ECONNRESET', Feb 26 02:32:12 volumio volumio[1651353]: response: undefined Feb 26 02:32:12 volumio volumio[1651353]: } Feb 26 02:32:12 volumio volumio[1651353]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:32:14 volumio sudo[1652581]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 02:31' Feb 26 02:32:14 volumio sudo[1652581]: 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"