Oct 24 22:41:00 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:00 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1130. Oct 24 22:41:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:02 volumio go-librespot[23366]: go-librespot daemon starting... Oct 24 22:41:02 volumio go-librespot[23367]: time="2025-10-24T22:41:02+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:02 volumio go-librespot[23367]: time="2025-10-24T22:41:02+01:00" level=debug msg="app state loaded" Oct 24 22:41:02 volumio go-librespot[23367]: time="2025-10-24T22:41:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=info msg="zeroconf server listening on port 39277" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="obtained new client token: AADMvpSGohPMwGGzNi6/2XQ0uFmHpzIc7AaXwwTo/sZ3mOa60oI4F8AXlapbZ0GxQYaTuHVbnR2DPHViRBoJSSbo7CK/E5NdMa2vE7B4cPJTr+RiBBp3gvIpk2cEQPO+uZ88fdv05+LYDAL6cMnZdQIIYeCj+bs9OqFAlAw9iCEQPjjbh9jCLko9zTuckNMLYQcgVgSvShUz51sNJA1HTdcmQIOogRPc4dbBvmia2VL3a6IuweuF" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=debug msg="completed challenge" Oct 24 22:41:03 volumio go-librespot[23367]: time="2025-10-24T22:41:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:03 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:03 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1131. Oct 24 22:41:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:06 volumio go-librespot[23388]: go-librespot daemon starting... Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="app state loaded" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=info msg="zeroconf server listening on port 36457" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="obtained new client token: AAD2KTAuwU7MZU70316nm9OHFfIwewnwkEbJEB/cGsi+M3JwGm1TzpsQGCx/yefvleGRcX10ZW1GlrpiekT0Qqoz5e8AltTdbrTogC5WdhYZiNdrBmGjJ9twk7ItqGmyeIhUCG32elcy805cVZAJkNtAzm6pyzj5l5NMjWoLntO2SMywbZlUBvxounkTKE15HC9Toat6eNiS0cdo/oP/+ozXrx1wSs2uJQDhaeB3CgvEyFfEyFJP/Us=" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=debug msg="completed challenge" Oct 24 22:41:06 volumio go-librespot[23389]: time="2025-10-24T22:41:06+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:06 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:06 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:09 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1132. Oct 24 22:41:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:09 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:09 volumio go-librespot[23397]: go-librespot daemon starting... Oct 24 22:41:09 volumio go-librespot[23398]: time="2025-10-24T22:41:09+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:09 volumio go-librespot[23398]: time="2025-10-24T22:41:09+01:00" level=debug msg="app state loaded" Oct 24 22:41:09 volumio go-librespot[23398]: time="2025-10-24T22:41:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=info msg="zeroconf server listening on port 40243" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="obtained new client token: AABAM7msHm0q9lNJlNrZjR1dQE9H5/5gcXqW7kSJC0U9dMoldC63cKXXIz8SyD1uMHYXvLjrtXz4ncQJVveLSFFqQs6yPwljEIGhda7jul58PXU6S3pnId3UXoeN9FZktHLFTZy1S7ru6nWEYFBXpYLKAakrlygoa55KhFh341vEOrOjVfHQLxIg/tbCjVzSrN/nT4dWIm1pJfDehaCLyDy438AY9SJn4fzGEmL3lXHBycSS8EAM" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=debug msg="completed challenge" Oct 24 22:41:10 volumio go-librespot[23398]: time="2025-10-24T22:41:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:12 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:12 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1133. Oct 24 22:41:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:13 volumio go-librespot[23405]: go-librespot daemon starting... Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="app state loaded" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=info msg="zeroconf server listening on port 35161" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="obtained new client token: AAChSYjrU/xERJLg2zF1iBOiNPPrPRmlc2B0Ak5Dtp4Yr3Ta8tMJO2ppnrTMqb29BecMoxtjxibmHgdZCZ/F/AI0qC3b/jc/4G209Qx6U89p/1+i5W0SpgEDjNrTSalGzLh1aDvbaMDGs+l6sMNnjgLHgo+JjwETFWgZ9MTpWsybcdsQpujNWyxSQ/te86nXblEUc01mGv+Y6rYOKt58mROIDxjO8XoEXRJUIAN3rIrZTzUYvkJ85Uc=" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=debug msg="completed challenge" Oct 24 22:41:13 volumio go-librespot[23406]: time="2025-10-24T22:41:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:15 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:15 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1134. Oct 24 22:41:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:16 volumio go-librespot[23427]: go-librespot daemon starting... Oct 24 22:41:16 volumio go-librespot[23428]: time="2025-10-24T22:41:16+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:16 volumio go-librespot[23428]: time="2025-10-24T22:41:16+01:00" level=debug msg="app state loaded" Oct 24 22:41:16 volumio go-librespot[23428]: time="2025-10-24T22:41:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=info msg="zeroconf server listening on port 45835" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="obtained new client token: AACB/grSWRJOQ77YHzerhv/S10n7hZySwuaajV+HSzRsPQmK2iZSd9Hdh7gfIUGlqawYYDd1tcvDy+1c5Sz48arHySHAL158QGEuX1DqiPVGFjGvl6uItax/kLcS9Gk7mT+pnGvjV1nUA6b4+k97IEX13/4we8pH/A0nZo3reAypG1xKOUYH8zEy8mGZWaCLmkBD1FdCz7mrlbe5iA6hpFH1auysgMVBDHz+RLwp7F24n+Casn3Q" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=debug msg="completed challenge" Oct 24 22:41:17 volumio go-librespot[23428]: time="2025-10-24T22:41:17+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:18 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:18 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1135. Oct 24 22:41:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:20 volumio go-librespot[23435]: go-librespot daemon starting... Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="app state loaded" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=info msg="zeroconf server listening on port 37121" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="obtained new client token: AABOoJ5+rTUhIF2sKkPjM0t08Cdl7gTCmqcuuwlCnzOAuN6XCaTxMjNuZAjCws2tWvzBn3Br7SQ7HX8s4UqQFVARI+nMa3a2SpMFP6LQZgKjT2CXb+iL1NIfZENU0r9VzzHsWcUFapE2Wlfi4zTH2zIDWgcdtq05BF9ShbBs8GA0cFkfRqZj47W/b/ARGFqfw/meyLxz6QEZ3zHx0SwZVZBkSfaiXDgkB+kCGRFaZkC7MEVF1nmAS0U=" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=debug msg="completed challenge" Oct 24 22:41:20 volumio go-librespot[23436]: time="2025-10-24T22:41:20+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Oct 24 22:41:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:21 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:21 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1136. Oct 24 22:41:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:23 volumio go-librespot[23447]: go-librespot daemon starting... Oct 24 22:41:23 volumio go-librespot[23448]: time="2025-10-24T22:41:23+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:23 volumio go-librespot[23448]: time="2025-10-24T22:41:23+01:00" level=debug msg="app state loaded" Oct 24 22:41:23 volumio go-librespot[23448]: time="2025-10-24T22:41:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=info msg="zeroconf server listening on port 42021" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="obtained new client token: AACmRPZcz7289ekszVTI6XWHuq8/9q+JqlQ7SaqlRiaWKhxu7p45sfZ2lU/6kYlLO1zt9mGFgJVk3DHYTQqW4iT6RY4KuBK7k3s6u4gbqCXE277aJ15BkhcjUQguPQJr2jzZxj3YB++FnTjIoSUaGwUxbWpEzqiBc7fYdYfo8KLfO6m+E3JZh8R0Z2bcz9+Z6/qGJVUx5/ZQRRWUsk/W5cQl9HVxgk4x77PAFblgoeaUoHb3VuA5" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=debug msg="completed challenge" Oct 24 22:41:24 volumio go-librespot[23448]: time="2025-10-24T22:41:24+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:24 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:24 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1137. Oct 24 22:41:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:27 volumio go-librespot[23469]: go-librespot daemon starting... Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="app state loaded" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=info msg="zeroconf server listening on port 40803" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="obtained new client token: AADFPBuVAQuc1xTHPyPTdcRb0aCIwSEv4T4H26RdbtemfZOcUPtDZGyDWQXeL0u5AF9ZHqt/jZPLwTZKGg9vKhs1a+s9Vgr8vafhjJvAat6MkVz1IiNtF/SNrJ1zCVc81lqd+ox6dkLzvZKCW/KiVXgebsFMUVCjJc9Qtsxm3Tjtw45cV4Q2siWpUTEz/xaxjfNHRQY/8RlFb3kjuBulYypzqRpJ8dM35AglsM8dSz8ChBqzH6URzWM=" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=debug msg="completed challenge" Oct 24 22:41:27 volumio go-librespot[23470]: time="2025-10-24T22:41:27+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:27 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:27 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:30 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:30 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1138. Oct 24 22:41:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:30 volumio go-librespot[23478]: go-librespot daemon starting... Oct 24 22:41:30 volumio go-librespot[23479]: time="2025-10-24T22:41:30+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:30 volumio go-librespot[23479]: time="2025-10-24T22:41:30+01:00" level=debug msg="app state loaded" Oct 24 22:41:30 volumio go-librespot[23479]: time="2025-10-24T22:41:30+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=info msg="zeroconf server listening on port 40931" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="obtained new client token: AAD2pRnWY70sYalOm/rjTFje41qQu+Evuy29pTmuOLuohfOLCBq3JG2bl4IpVprJkuOzdUGcE3B8Ikjth4jOEIAOwcX/OxgAqoa/f3OLw7UbnYNm15jyWgxvtgra2HfFSR5jE4JTfO4onpuxAlG/Hg2pRsGdxwxG7/Yu5u0dzdvRThmB3mPgZci42wFzdxUu+Tdap6L+x0SvMb1djzYXPeUABYnZNF1UspKALRzQhl1sLkjkbYnt" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=debug msg="completed challenge" Oct 24 22:41:31 volumio go-librespot[23479]: time="2025-10-24T22:41:31+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:33 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:33 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1139. Oct 24 22:41:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:34 volumio go-librespot[23486]: go-librespot daemon starting... Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="app state loaded" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=info msg="zeroconf server listening on port 36607" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="obtained new client token: AAB2PcjtfiEjZiKT2JC9AzmPKT/iR/8qlMWiszxFqmzV6hjIkHGJNBnKXdUZH9TL7xKsH1XebA/L8rhKMKxb1DibAK++iJ5/3Zpz+pmfUSbRrISNfWYyM1Enyd5r6+tGF/xo+bqFvPrSizd6EMYXoBSVf9gTmdKgTTjqQ+hbcoiWvjeVdl5vbyy6bLG5DkAK8TlG8GEVhTJ7So7WTmXOhAr5omhkrZLpNQ/ZeHLoU1e1nkn4/ZluhYw=" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=debug msg="completed challenge" Oct 24 22:41:34 volumio go-librespot[23487]: time="2025-10-24T22:41:34+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:36 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:36 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1140. Oct 24 22:41:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:37 volumio go-librespot[23508]: go-librespot daemon starting... Oct 24 22:41:37 volumio go-librespot[23509]: time="2025-10-24T22:41:37+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:37 volumio go-librespot[23509]: time="2025-10-24T22:41:37+01:00" level=debug msg="app state loaded" Oct 24 22:41:37 volumio go-librespot[23509]: time="2025-10-24T22:41:37+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=info msg="zeroconf server listening on port 35127" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="obtained new client token: AAC7+cAn0wEiWsETcabS5hTgSp3diqCKkIGt4YFwToqBk5Hcx+IxFahlEehLcrnwdZM2s+m76A5c1COLYJVZ4lnq46mfejby64RX+mZbIirQXoVgJiUXvcveQBnXz2iUlgbllFbQ64pY2Mhk98fV0ZJXA7qIhO/E1J+xXMyyLjfzwgAYo7IWusXIr+ZT3DPSiY03oyM1ppvHip9yJYQnUqJKZUbH+TNfaatXkSxkTV64cP2w7TVW" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=debug msg="completed challenge" Oct 24 22:41:38 volumio go-librespot[23509]: time="2025-10-24T22:41:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:39 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:39 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1141. Oct 24 22:41:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:41 volumio go-librespot[23516]: go-librespot daemon starting... Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="app state loaded" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=info msg="zeroconf server listening on port 34455" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="obtained new client token: AADADiGaD8FlwkfECs0KQGDBopr0ymWb6VtbQ4zV+2TjgAaRSQbUCOMRxAuKVIxbQques5mAvcNpOPjcwnKHDdjagV1Zdo/ZX2/9uYbqXseSSz0uxcBVNQaciz4hWOT6QA98EfTLMFFbz1jIRP0DAPjiMov5jCMC0btIjCi6lwjwbKDByVeiFAFCbmTK9gleDbBa9AXbeMZ5nc1/BcPLj80T2nsUF3E8UBI5OxhlkjCjydbCIAAQUUE=" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=debug msg="completed challenge" Oct 24 22:41:41 volumio go-librespot[23517]: time="2025-10-24T22:41:41+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:42 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:42 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1142. Oct 24 22:41:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:44 volumio go-librespot[23528]: go-librespot daemon starting... Oct 24 22:41:44 volumio go-librespot[23529]: time="2025-10-24T22:41:44+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:44 volumio go-librespot[23529]: time="2025-10-24T22:41:44+01:00" level=debug msg="app state loaded" Oct 24 22:41:44 volumio go-librespot[23529]: time="2025-10-24T22:41:44+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=info msg="zeroconf server listening on port 34049" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="obtained new client token: AABEQHWgaqs3V0YUVEgoPrBGtY3x2xmLHskqgmuOlz7iUEVmLGZJEniNYIXizXJ+CjtSA84c36zbhT2jHWJJMkxQ9O/GYw7DKGC/q4twHRfb2K0XWzBff0+wQ9fkat4cEMPYvCiFUttSfUbsO5Lt6VdlvV2rB1ZrADXac1nKuNqu+B968r6cegLzr79qrWRPzBf7CUTpLI/mKONQuRSRb72PwfM6z7+QxFndmQAn+uSenHkM7laJ" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=debug msg="completed challenge" Oct 24 22:41:45 volumio go-librespot[23529]: time="2025-10-24T22:41:45+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:45 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:45 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1143. Oct 24 22:41:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:48 volumio go-librespot[23550]: go-librespot daemon starting... Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="app state loaded" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=info msg="zeroconf server listening on port 37943" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="obtained new client token: AAAMjrWgx7z+WY4H2BSux314M0cp6M3UHxSJMgD1MHnjIlqswNJ6z3NwyRVslGDnTpPW9jTnSJbopxZ/fblitw3g+erGyX2/l+UMJ/zsEUJM6EtES/Z+RuSpV33VgMgiIGJS/u8bCz0U+k1QZj4b0L4Mq+5luw2179gQAnbd/vU4sy8CnqaIQr95Wi8RguX73gRely2xbFS+VkrPy3T8v6naOtTP7sf+pR7/ACEfTY6tpH2ezr9Esi4=" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=debug msg="completed challenge" Oct 24 22:41:48 volumio go-librespot[23551]: time="2025-10-24T22:41:48+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:48 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:48 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:51 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:51 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1144. Oct 24 22:41:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:51 volumio go-librespot[23558]: go-librespot daemon starting... Oct 24 22:41:51 volumio go-librespot[23559]: time="2025-10-24T22:41:51+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:51 volumio go-librespot[23559]: time="2025-10-24T22:41:51+01:00" level=debug msg="app state loaded" Oct 24 22:41:51 volumio go-librespot[23559]: time="2025-10-24T22:41:51+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=info msg="zeroconf server listening on port 45373" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="obtained new client token: AADMNrYAbEn18sX9Cx/T/PqnY7Pgx76+TgHE4rxL3c5xskMcbz2kS4bVqrDKiZNx/eysRCJpUNCMKr1B5C+DXD8yEzuOYGUPqxMEMB2ZL5z3gZ3EzANdq18GpyMzZ0Ix2kCESjoq4lq30OWM4nmlUQZp7H/rNhMXSBboaslaDG9SvFBregwo51IjMGoG1pv4XsU1W1YrWQJB+iAXojWWw4vAQR2Ooof+SVTLjdBld3KUyFBKfPeT" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=debug msg="completed challenge" Oct 24 22:41:52 volumio go-librespot[23559]: time="2025-10-24T22:41:52+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:54 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:54 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1145. Oct 24 22:41:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:55 volumio go-librespot[23581]: go-librespot daemon starting... Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="app state loaded" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=info msg="zeroconf server listening on port 35735" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="obtained new client token: AACc3QE8txLs/pVp5S88f2y/sADD4UWqNdRg3YIteF826Pt3gPg6eeqLmZmssdM9JWDNXoKR4Alr+TyYa0cmrzfbBTK52zgRJ2H+fvdCEPF+CotGKEKKwdZ12rdyxpnPiEa16jfjQCeHuDHRYJDWNktE0XDopCiE4mb3TA3ymNfYfD/dxCCdPdPkh0EOr/opYPd5kJbqkJlWaTiw8fszMj+bAvNaOVfqLeuODKhRR2mBU7UUaebMD3g=" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=debug msg="completed challenge" Oct 24 22:41:55 volumio go-librespot[23582]: time="2025-10-24T22:41:55+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:41:57 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:41:57 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:41:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1146. Oct 24 22:41:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:41:58 volumio go-librespot[23589]: go-librespot daemon starting... Oct 24 22:41:58 volumio go-librespot[23590]: time="2025-10-24T22:41:58+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:41:58 volumio go-librespot[23590]: time="2025-10-24T22:41:58+01:00" level=debug msg="app state loaded" Oct 24 22:41:58 volumio go-librespot[23590]: time="2025-10-24T22:41:58+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=info msg="zeroconf server listening on port 37295" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="obtained new client token: AADEYbNxW+FPzrsqqFpzUUjy8gJqcgeAJZqYmG47voyQt+KcE8xCTjDUZmqB8osQ7+0+pjPUZ1hijgEAnGSKDcbkMyp2fZJroh6E7e9GkOG8G0YawQS8K3l99Y/R3uz1G+TIHOGkS7Ff4pQQ1cVlhqE0EMhl0H/hZAiwVeAQ+O/CWVfOpP0e9bm4fWd+tSQLEMIgjJMOeQXsoUvBuJHYRt9a6x1Cy+eQlIbyxx3d5JWAoQMeJJ3o" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="completed keyexchange" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=debug msg="completed challenge" Oct 24 22:41:59 volumio go-librespot[23590]: time="2025-10-24T22:41:59+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:41:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:41:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:42:00 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:42:00 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:42:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1147. Oct 24 22:42:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:42:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:42:02 volumio go-librespot[23600]: go-librespot daemon starting... Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="app state loaded" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=info msg="zeroconf server listening on port 42363" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="obtained new client token: AABHjYPyrpr1xXvDifBS2DPKUNok31cXz6N+qzbDh/vl2UhNxRygTfSohyQxYPCzL9HJkionm6SM8c6h8jfLj47fZUrNknYT/f253HRVOoU+0TrKjq5pI3DxUGQMP73qc60F8fI6zUwhsuRQiVpYOX3cCCMNrMITVtlyJnMhIQtpA9w8qX5AP9GB/1NedeNC4hmXp8paZn5MmUsEDUmiwxZrhIOwWbInN1n+xxuD2Bhyo9uj2ByB/mU=" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="completed keyexchange" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=debug msg="completed challenge" Oct 24 22:42:02 volumio go-librespot[23601]: time="2025-10-24T22:42:02+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:42:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:42:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:42:03 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:42:03 volumio volumio[22623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 22:42:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1148. Oct 24 22:42:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:42:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 22:42:05 volumio go-librespot[23622]: go-librespot daemon starting... Oct 24 22:42:05 volumio go-librespot[23623]: time="2025-10-24T22:42:05+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 22:42:05 volumio go-librespot[23623]: time="2025-10-24T22:42:05+01:00" level=debug msg="app state loaded" Oct 24 22:42:05 volumio go-librespot[23623]: time="2025-10-24T22:42:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 22:42:06 volumio go-librespot[23623]: time="2025-10-24T22:42:06+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 22:42:06 volumio go-librespot[23623]: time="2025-10-24T22:42:06+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 22:42:06 volumio go-librespot[23623]: time="2025-10-24T22:42:06+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 22:42:06 volumio go-librespot[23623]: time="2025-10-24T22:42:06+01:00" level=info msg="zeroconf server listening on port 42947" Oct 24 22:42:06 volumio volumio[22623]: info: Initializing connection to go-librespot Websocket Oct 24 22:42:06 volumio go-librespot[23623]: time="2025-10-24T22:42:06+01:00" level=debug msg="new websocket client" Oct 24 22:42:06 volumio volumio[22623]: info: Connection to go-librespot Websocket established Oct 24 22:42:09 volumio volumio[22623]: info: Getting Spotify volume Oct 24 22:42:09 volumio volumio[22623]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 24 22:42:09 volumio volumio[22623]: info: CoreCommandRouter::volumioGetState Oct 24 22:42:09 volumio volumio[22623]: info: CorePlayQueue::getTrack 0 Oct 24 22:42:09 volumio volumio[22623]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Oct 24 22:42:09 volumio volumio[22623]: SPOTIFY: SPOTIFY VOLUME undefined Oct 24 22:42:09 volumio volumio[22623]: SPOTIFY: VOLUMIO VOLUME 51 Oct 24 22:42:09 volumio volumio[22623]: info: Aligning Spotify Volume to Volumio Volume Oct 24 22:42:09 volumio volumio[22623]: info: CoreCommandRouter::volumioGetState Oct 24 22:42:09 volumio volumio[22623]: info: CorePlayQueue::getTrack 0 Oct 24 22:42:09 volumio volumio[22623]: info: Setting Spotify Volume from Volumio: 51 Oct 24 22:42:10 volumio go-librespot[23623]: time="2025-10-24T22:42:10+01:00" level=debug msg="obtained new client token: AABM3RG8xSaTpjHF+ihf5cfLG8bhYTYgDW77nb5jPhC0dE+TzvpXxbz6lZCwii66n397EmeIFkJHvM7wBNU6BL+SnHheU4Y/W7oo+fYPFmAftet2ifNa9Hc/a+JXFl7F74xPKvSxsUrHYHHUenZ2pEzP6hqEPOgve0jSvZOJlR+xHhGpyi72rgURmLbQ0Ci4dgMeqq5BEcI3fjyXvtDdVQQ5joWL0HbRYB+VXx8iLBnXjPG1i1Pzj3w=" Oct 24 22:42:10 volumio go-librespot[23623]: time="2025-10-24T22:42:10+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 22:42:10 volumio go-librespot[23623]: time="2025-10-24T22:42:10+01:00" level=debug msg="completed keyexchange" Oct 24 22:42:10 volumio go-librespot[23623]: time="2025-10-24T22:42:10+01:00" level=debug msg="completed challenge" Oct 24 22:42:10 volumio go-librespot[23623]: time="2025-10-24T22:42:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 22:42:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 22:42:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 22:42:10 volumio volumio[22623]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:42:10 volumio volumio[22623]: Error: socket hang up Oct 24 22:42:10 volumio volumio[22623]: at connResetException (node:internal/errors:720:14) Oct 24 22:42:10 volumio volumio[22623]: at Socket.socketOnEnd (node:_http_client:519:23) Oct 24 22:42:10 volumio volumio[22623]: at Socket.emit (node:events:526:35) Oct 24 22:42:10 volumio volumio[22623]: at endReadableNT (node:internal/streams/readable:1376:12) Oct 24 22:42:10 volumio volumio[22623]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Oct 24 22:42:10 volumio volumio[22623]: code: 'ECONNRESET', Oct 24 22:42:10 volumio volumio[22623]: response: undefined Oct 24 22:42:10 volumio volumio[22623]: } Oct 24 22:42:10 volumio volumio[22623]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:42:11 volumio sudo[23644]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-24 22:41' Oct 24 22:42:11 volumio sudo[23644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="c22b72a8acb34a699a626adb0a09a6b88ee7233a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="40400d6a6fa57cf20e36499e510876b3654e9c4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Oct 4 16:40:08 UTC 2025" VOLUMIO_VERSION="4.061" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7f8ace80645f85765fa10c72d1769d04"