Oct 31 05:36:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 226. Oct 31 05:36:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:00 volumio go-librespot[27148]: go-librespot daemon starting... Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=debug msg="app state loaded" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" 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 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" 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 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" 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 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=info msg="zeroconf server listening on port 39299" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=debug msg="obtained new client token: AAD8uXlmuqEduYpeZ5Q9CrpZQryhj7Mc5asmPJOeguRwmkM2zGCf5vgrowrb/I1WvhKYHQVC9Kl+qcV4AUObbk6njAJq/n/C3SNNnyL5knxsub+veiswPmUWNkRxz0dVuvT3tVSVMWs1Vmx1d54n88piW1Gsv9H2Vjativ0C1nVa4mUBr0y+owdP04tdXcODFT95gdAI5gyw9ZJWIqnJYsuCLlPqLre7poxCiVeM84pWzNkq53bxet0=" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=debug msg="completed keyexchange" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=debug msg="completed challenge" Oct 31 05:36:00 volumio go-librespot[27149]: time="2025-10-31T05:36:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:00 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:00 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:03 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:03 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 227. Oct 31 05:36:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:03 volumio go-librespot[27171]: go-librespot daemon starting... Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=debug msg="app state loaded" Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" 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 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" 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 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" 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 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=info msg="zeroconf server listening on port 46527" Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=debug msg="obtained new client token: AAAkPUhP3I3AbrZR5GK+XYBWKP0mMSGEblTthNjbUaQulgujNu8l9IieBGEXr0WdLmXxjyqwdxai+sSCIyD7wiDUwt1zHtSk0fQCHF2nefa0yW60rY9LXAdU40sQUdfiga3knug0EBE0snuzCWRYtY7oZFpxL2MQO40BeK6n/dHqAK1VVYyAtTUVJhQmofhjtoy/ZVbkqeQJasewZ4OV0rs/vHIR5LCZwOY3H2ErakrAqfspbSYFXIM=" Oct 31 05:36:03 volumio go-librespot[27172]: time="2025-10-31T05:36:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:04 volumio go-librespot[27172]: time="2025-10-31T05:36:04Z" level=debug msg="completed keyexchange" Oct 31 05:36:04 volumio go-librespot[27172]: time="2025-10-31T05:36:04Z" level=debug msg="completed challenge" Oct 31 05:36:04 volumio go-librespot[27172]: time="2025-10-31T05:36:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:04 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:36:06 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:06 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 228. Oct 31 05:36:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:07 volumio go-librespot[27180]: go-librespot daemon starting... Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=debug msg="app state loaded" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" 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 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" 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 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" 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 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=info msg="zeroconf server listening on port 46197" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=debug msg="obtained new client token: AACnVWSXtlW+VYtMF3UxWFKInJeCdD3ffKAeQj8HS7fpvGetZH3Zlo1jgPYNtC//2wFoeTx1C/5FuR/lQyWy9oWb2ytOt57Jg5q69cpePsf1GdGBP7npGrKvuYhlhnkjTZH7Y+Xp3YbY4sCfAP7UQx9dqaRMaQHvA740rh5PkT/Z5Im4MOpEAukP2SiL5TSst9SQ9Q0C0QmEQADHF4x9c5V+OoBq+I8ZsxsNpB2cYzTDPaqwnmjcGCo=" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=debug msg="completed keyexchange" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=debug msg="completed challenge" Oct 31 05:36:07 volumio go-librespot[27181]: time="2025-10-31T05:36:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:09 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:09 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 229. Oct 31 05:36:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:10 volumio go-librespot[27188]: go-librespot daemon starting... Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=debug msg="app state loaded" Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" 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 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" 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 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" 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 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=info msg="zeroconf server listening on port 41879" Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=debug msg="obtained new client token: AABRFcKJ0HEqzBrZazhEPl1u50139jO/qphJ4iT6AniE7ugWrlonxmyk4kKAaHztRHpbV/79qA5w5DT/7t9+q3ev6D6t7TzdwgkMm58gjokPzlb/Nt9tbg8YRdAOdsSQsZACo/42uPz5eYRVhVQCPlnZ76RcWN3dmN+R0n7eCf8Rz+0cC5mg7JRcqY3OT0NRDpvEKh42xpkUAFlPs1h7QiHcshT0ZXF1Q1NE3rCEW/85UaOIb5kKBwc=" Oct 31 05:36:10 volumio go-librespot[27189]: time="2025-10-31T05:36:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:11 volumio go-librespot[27189]: time="2025-10-31T05:36:11Z" level=debug msg="completed keyexchange" Oct 31 05:36:11 volumio go-librespot[27189]: time="2025-10-31T05:36:11Z" level=debug msg="completed challenge" Oct 31 05:36:11 volumio go-librespot[27189]: time="2025-10-31T05:36:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:12 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:12 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:13 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:36:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 230. Oct 31 05:36:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:14 volumio go-librespot[27211]: go-librespot daemon starting... Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=debug msg="app state loaded" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" 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 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" 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 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" 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 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=info msg="zeroconf server listening on port 34293" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=debug msg="obtained new client token: AABhirn7oo5xBUjv/u1OYKuKPLkuxBWJA5hx07gN5uNGvOKWc7I9oLW4SP6/09i3hLETJhAnTU45KsqlmLlSWYubVTwbPX2/x84Bq99vrkE+cEC6c0BrOcuHyRmH2mK/ZLm96Ay9naNeqQgC2fpIzLKemVspDpNgyNDhSdOoZLQJ+TxVLS2AV5sWwdT294HagWW05WRznLzj+V+LSUwwTkzvZloi8L52zz1juKRJXd72nKLxPQgNP4g=" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=debug msg="completed keyexchange" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=debug msg="completed challenge" Oct 31 05:36:14 volumio go-librespot[27212]: time="2025-10-31T05:36:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:15 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:15 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 231. Oct 31 05:36:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:17 volumio go-librespot[27219]: go-librespot daemon starting... Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=debug msg="app state loaded" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" 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 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" 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 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" 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 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=info msg="zeroconf server listening on port 36243" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=debug msg="obtained new client token: AADcHjjcBIknyn4Bu6vQB+bDPOnohqC7lYcFV+t4ZmU7Nz/Qr8RWVVFUXzzC3KWCwwNGrgX7TrWj0dxWUZ+MC1ZG/su105xi+Xt0aErPl4eYioV1hw2k6kTWlfXq480tAcpji+Obb4qFbPmXmkmyHpVL7kxKXzEEE+P8mjllLqsghOxLotFeuCG09/EYQi0XWv2wIVWnHmbJSRck33rLIObO1LvcoDCuwInLfVAFabJTrZ9+dmhgb5o=" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=debug msg="completed keyexchange" Oct 31 05:36:17 volumio go-librespot[27220]: time="2025-10-31T05:36:17Z" level=debug msg="completed challenge" Oct 31 05:36:18 volumio go-librespot[27220]: time="2025-10-31T05:36:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:18 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:18 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 232. Oct 31 05:36:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:21 volumio go-librespot[27230]: go-librespot daemon starting... Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=debug msg="app state loaded" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" 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 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" 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 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" 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 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=info msg="zeroconf server listening on port 33289" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=debug msg="obtained new client token: AACJMIOHuYzCA6TrTv2Ch9QUDEb1WfQQCER7KO+Lh14KqtZk7qrZC7UoIXpJwNimL636DCJOz3NCYYnTeUxiLq6vZiCxjsabmAhR8mhW3zz2N/21WzLrrHRpApUekQBs/Ilg/P+0TzjBQBCPj5VuQWmuep8r0c+glwmD4jHcXGA5vCbQR8gl2M5iqKa4WyiTU0SM/7xTy20y8BajPqALOrL6Oz/CWQYdb3g/x79XB24HRgm/u0/Mjao=" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=debug msg="completed keyexchange" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=debug msg="completed challenge" Oct 31 05:36:21 volumio go-librespot[27231]: time="2025-10-31T05:36:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:21 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:21 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:24 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:36:24 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:24 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 233. Oct 31 05:36:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:24 volumio go-librespot[27252]: go-librespot daemon starting... Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=debug msg="app state loaded" Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" 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 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" 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 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" 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 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=info msg="zeroconf server listening on port 37095" Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=debug msg="obtained new client token: AACpULDmrX94YFrEG7JWBM3aWhOSvkNu970s8P4Xy4miUA6WW4bg08iZvVbb5HUoU2wHckcjKVonNxnj6+GQYdJ9Vk1mOfCJCx5XkwV8F/yglSlNgGvv8mhtHfBjU6vrOUKBXIqkhqv2G8N8Y75iRCfxTqH24TTM6JeCRsiMaGV212c5AFUbUE39f614Q2NvdiRANbKbrkoCQa8b9XG4RekgjKCHx/06YylKeuceHnGiPSHk5c+VZ1I=" Oct 31 05:36:24 volumio go-librespot[27253]: time="2025-10-31T05:36:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:25 volumio go-librespot[27253]: time="2025-10-31T05:36:25Z" level=debug msg="completed keyexchange" Oct 31 05:36:25 volumio go-librespot[27253]: time="2025-10-31T05:36:25Z" level=debug msg="completed challenge" Oct 31 05:36:25 volumio go-librespot[27253]: time="2025-10-31T05:36:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:27 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:27 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 234. Oct 31 05:36:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:28 volumio go-librespot[27260]: go-librespot daemon starting... Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=debug msg="app state loaded" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" 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 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" 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 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" 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 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=info msg="zeroconf server listening on port 33337" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=debug msg="obtained new client token: AADLeWnEXXLgQqrQT3vClyirUGB7L2XesDxnh3zb5gp/DMPxyyrdCuvxRQdJsNNFB5TFTydUzuLRMyNz7plnxgKW5sSebzhOImNBXVs/tbRmd5o+HWRJ2LKsGy9IIVisH9ANqFMrdALCUT2bYSQ/8STYj6tSMhicIsMu7sdHgs3crKYW4+Q6YVPYvsupvJtHGFdCG2gQCWRTdyb0y4w0TkYWsdEZkSY0Dea3xFMaPCjA++nTg4Yvr2Q=" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=debug msg="completed keyexchange" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=debug msg="completed challenge" Oct 31 05:36:28 volumio go-librespot[27261]: time="2025-10-31T05:36:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:30 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:30 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 235. Oct 31 05:36:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:31 volumio go-librespot[27269]: go-librespot daemon starting... Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=debug msg="app state loaded" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" 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 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" 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 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" 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 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=info msg="zeroconf server listening on port 43743" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=debug msg="obtained new client token: AAD1xKlfXtnOCpGKnBt3dor1YA9bQUXz8vlJILYvKQM8QyC3QsBiQ/FBgM8Sm3QsV46DPxjdFKfcCs8EYcBbYqAh3RcxYpWcJpa7GV6bCUETsj7zB0haM448IKMu2lbeWgB3bI18yqStsfFSAHyVTKLo/BOKWRnjSobEW7QznW7hW2nbEfMkWGXUNm+08jfkqVh/ZNkpjWPO9n3iDPblmswz1JQsjsvG7Ds2utYZLvurt3MhxuPDeEk=" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=debug msg="completed keyexchange" Oct 31 05:36:31 volumio go-librespot[27270]: time="2025-10-31T05:36:31Z" level=debug msg="completed challenge" Oct 31 05:36:32 volumio go-librespot[27270]: time="2025-10-31T05:36:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:33 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:33 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 236. Oct 31 05:36:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:35 volumio go-librespot[27292]: go-librespot daemon starting... Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=debug msg="app state loaded" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" 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 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" 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 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" 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 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=info msg="zeroconf server listening on port 39481" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=debug msg="obtained new client token: AABhC5JD0n/+EMcHKBPD3JsKvETD8wM45mYY8uUycBtEr+TszW02R0FOjYQo0knAww38b3oL2P0oTPzLe3QIDWkDtVdgeEDD7t+66uzt7SesUhI+G7jdZfNJJ/kZj8zM9jv4GzzoFvB7oTSCH4hszZxMnz9sWZVxdHyNHYiamNuUtEAp2VuERKOJnMGZYhqKOm2atvYw3YnAvZRRGhJNVyslYps7cpNozHU+eqio/wSqiWGpf/Hp7r8=" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=debug msg="completed keyexchange" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=debug msg="completed challenge" Oct 31 05:36:35 volumio go-librespot[27293]: time="2025-10-31T05:36:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:36 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:36 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:38 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:36:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237. Oct 31 05:36:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:38 volumio go-librespot[27303]: go-librespot daemon starting... Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=debug msg="app state loaded" Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" 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 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" 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 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" 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 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=info msg="zeroconf server listening on port 44833" Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=debug msg="obtained new client token: AACjcf2XBR4NJpZ0xGkjnaLabRJ932jEC8XH57F+v5KhLqLwBJyOCxG20KtsLgzlNREBZWZ6shzRXTRS3/HrJByFI/b6MugXzhIzN5tI8Tmu0+1+PaKM/OmdRyajA9IdUCtFb8rcn6drVWDkl9GVKjuDtHf0DckEs7+vn5lP0ZcEICVoiAFRlJRREyw1JRkYZuBim9fnTIjrptFWq8YyoQRP8vCnfHu7l9tCvLXSxvyjBvRbsC4KK28=" Oct 31 05:36:38 volumio go-librespot[27304]: time="2025-10-31T05:36:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:39 volumio go-librespot[27304]: time="2025-10-31T05:36:39Z" level=debug msg="completed keyexchange" Oct 31 05:36:39 volumio go-librespot[27304]: time="2025-10-31T05:36:39Z" level=debug msg="completed challenge" Oct 31 05:36:39 volumio go-librespot[27304]: time="2025-10-31T05:36:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:39 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:39 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 238. Oct 31 05:36:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:42 volumio go-librespot[27312]: go-librespot daemon starting... Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=debug msg="app state loaded" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" 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 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" 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 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" 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 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=info msg="zeroconf server listening on port 46197" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=debug msg="obtained new client token: AADYY8AThZGu56aeXv82jD5GOpAVRPlErlWZ6Tpg4auBA2JnEiJ5AhJnMCz8HXBmUq2yujCys/yR5mZLBLNsu8qXTQq0Dgg+coPrZ1aSovo9P5dhEV5FpqK3QJryYzNdko7SuzEIexOJBxuJfYzTW08cjfn+QLylzvMtiGfxiQRN7O8tpaClrkdH0l7Epu0NPR/CnKvMqdTG7K5SQCe2qCnljx4E2N6tn36SO0pP2QUsiJ4ANlwCoTI=" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=debug msg="completed keyexchange" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=debug msg="completed challenge" Oct 31 05:36:42 volumio go-librespot[27313]: time="2025-10-31T05:36:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:42 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:42 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 239. Oct 31 05:36:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:45 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:45 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:45 volumio go-librespot[27334]: go-librespot daemon starting... Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=debug msg="app state loaded" Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" 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 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" 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 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" 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 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=info msg="zeroconf server listening on port 44145" Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=debug msg="obtained new client token: AAB66b7a5OiZzFsMPq7tIxkJtCRInijC0oaJbAlSE2Dv9kfUvrbcz/0pi89pG4Af9BEX7AQwsDXXtzOLKwzNqmXiuWKPbf0Qd7LU3rblMtcALZhM8qYLdW5PucmajuGDdOEn5FYn1Yp4NTa4dsLzGyV+u7OJFztZbPtu06qHKDIXsGd1kb6652tVQ9SxrIKGuGUuzpKlTbLnJ1UZ8VQFzZ9ebS/X9U7oSR/Rw8eTHtsU/bbAM7I7Q+s=" Oct 31 05:36:45 volumio go-librespot[27335]: time="2025-10-31T05:36:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:46 volumio go-librespot[27335]: time="2025-10-31T05:36:46Z" level=debug msg="completed keyexchange" Oct 31 05:36:46 volumio go-librespot[27335]: time="2025-10-31T05:36:46Z" level=debug msg="completed challenge" Oct 31 05:36:46 volumio go-librespot[27335]: time="2025-10-31T05:36:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:48 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:48 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 240. Oct 31 05:36:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:49 volumio go-librespot[27343]: go-librespot daemon starting... Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=debug msg="app state loaded" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" 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 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" 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 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" 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 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=info msg="zeroconf server listening on port 37875" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=debug msg="obtained new client token: AACB1jpfmndtvvz+a6VPPmisjIETMpCdX7uPK3DZVnQG/YyM8pzavSnRhioPK6f7+W5foX7LAxj6R4Wfvti+tcS1Ej/pkMLC7nVVABrX24shA7UCcLY1xyeOM0VJD68H8/3y9vVc+QKtUxhdnemJcrEaFhCUuHz83PVxb/2cEI6NrQ4/Fc2dSnVvd/Zkdq5O75EVU3SbH9ZZzqOJQscxPL8PhYCFRQM4chOnx6m/EhDdQgXyiIsahsw=" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=debug msg="completed keyexchange" Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=debug msg="completed challenge" Oct 31 05:36:49 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:36:49 volumio go-librespot[27344]: time="2025-10-31T05:36:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:51 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:51 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 241. Oct 31 05:36:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:52 volumio go-librespot[27351]: go-librespot daemon starting... Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=debug msg="app state loaded" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" 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 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" 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 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" 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 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=info msg="zeroconf server listening on port 46509" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=debug msg="obtained new client token: AADtDQ+FJ2Od04to8e87z1w3sl/5bXAq0z+g+m6c6sppc6v4+5xbnXZlxr8RzyWcexUTy/UMO08E63mk6ide/eZpjjKI2iqaMiqhVnyWRMFq9Rpm7clB0kV4o/C9SfGLzHHnCPX7FL4bf/bBWOImxkNJspnnfqCKpTzp+VTKV1se6QWmwcbpnN0hSl6/YmZbSDmatSaSmCUaQLuDKali9WO2JXF4lNWIgNnV7suFy6AsVysEocTP9XM=" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=debug msg="completed keyexchange" Oct 31 05:36:52 volumio go-librespot[27352]: time="2025-10-31T05:36:52Z" level=debug msg="completed challenge" Oct 31 05:36:53 volumio go-librespot[27352]: time="2025-10-31T05:36:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:54 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:54 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 242. Oct 31 05:36:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:56 volumio go-librespot[27374]: go-librespot daemon starting... Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=debug msg="app state loaded" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" 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 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" 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 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" 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 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=info msg="zeroconf server listening on port 45487" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=debug msg="obtained new client token: AABY3nUxoYk/On6xmHH+gffcXAuLRyYjJAK3KxNed82PDGIuASwM8f0HoEO/lMAwmiPwt0xanKwTyzrf0klXc4s4nTzQu3z68uxRVVN8zkR1k9P9j6cTumCL9v6ankpl2SW8gSA54l5RasH38rgyDhvZnFmlQtUpkzdvxMy0D66Gx7TyA8OijCshWv7aDe3E00eJtnmzLFpH2HWpRsG9YhPujFm/xVOQpZ6TqGP7c04xWf95OCGZ7jI=" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=debug msg="completed keyexchange" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=debug msg="completed challenge" Oct 31 05:36:56 volumio go-librespot[27375]: time="2025-10-31T05:36:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:36:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:36:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:36:57 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:36:57 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:36:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 243. Oct 31 05:36:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:36:59 volumio go-librespot[27386]: go-librespot daemon starting... Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=debug msg="app state loaded" Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" 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 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" 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 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" 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 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=info msg="zeroconf server listening on port 41827" Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=debug msg="obtained new client token: AAA5aCjt7HTxZuGgr6UP1ckej20FkUFC9fr5u1uKvaFSkQMz5iS1hKyg8RVwGTqNdITEXLx1PWI0uVgHuGb9IWXiU1RHQn9hcqmqTKwBuhkLToNLzuESnjXkHIM+6fxC8pQ+LPquanyoB8jEW7oKb/KxHi/+RRw86wJaFJFeVvx6z8VlwoQj406Z2C25+F+AGOfRvtpJ0f2qGNHsn4ctOknnWideSzoqFmim1sdMlEMheCBifJFfT5g=" Oct 31 05:36:59 volumio go-librespot[27387]: time="2025-10-31T05:36:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:00 volumio go-librespot[27387]: time="2025-10-31T05:37:00Z" level=debug msg="completed keyexchange" Oct 31 05:37:00 volumio go-librespot[27387]: time="2025-10-31T05:37:00Z" level=debug msg="completed challenge" Oct 31 05:37:00 volumio go-librespot[27387]: time="2025-10-31T05:37:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:00 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:00 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:02 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:37:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 244. Oct 31 05:37:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:03 volumio go-librespot[27408]: go-librespot daemon starting... Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=debug msg="app state loaded" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" 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 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" 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 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" 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 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=info msg="zeroconf server listening on port 34235" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=debug msg="obtained new client token: AABynIUFOvUB6r+aW2ghTjGUKgyhUyPxL0MPxduoLkxzGzIN0GAwYyfwWVO5vrr6XT0Xg1+6UtuT0imOIHfvvwiAsxJMw1EzFCgMJd9y3lYs2FRT0aTWogXjYY+ouDJwLQEgsQsPG0K0tGCVd+cV1B5M/3FRlzE/vMgMW5aLr4sFRUlLyV6XCWYF4h5Upp+q61gJ9M4ok3LWUv7nn1TI5BEX/fAxvspn33/cwq8FxgvzY/7LkBLvdD4=" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=debug msg="completed keyexchange" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=debug msg="completed challenge" Oct 31 05:37:03 volumio go-librespot[27409]: time="2025-10-31T05:37:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:03 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:03 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 245. Oct 31 05:37:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:06 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:06 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:06 volumio go-librespot[27416]: go-librespot daemon starting... Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=debug msg="app state loaded" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" 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 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" 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 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" 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 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=info msg="zeroconf server listening on port 43317" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=debug msg="obtained new client token: AADBT5d8J+hMetnNazkC5r/g0+s+FKN9AsxFMRf+B4rFgq0ArKCdrRO6pdqP3U5M2Jf3WTlez1uN5qFxmli8WHVw4e5bk5OInr9rfAb4+hW4CNVZZcft3037MjL4WkutquDnK9FdGf6AjYdljrPl9AtccJjAsAs9DsGs5Q2JPijWsCUDMtgIiSEKNdHH4r7gpc9EnY7nyOfrhMMlZK1OKLitqZDXGHVuSgq/Z3DhS1EVcUopjuTY1uc=" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=debug msg="completed keyexchange" Oct 31 05:37:06 volumio go-librespot[27417]: time="2025-10-31T05:37:06Z" level=debug msg="completed challenge" Oct 31 05:37:07 volumio go-librespot[27417]: time="2025-10-31T05:37:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:09 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:09 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 246. Oct 31 05:37:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:10 volumio go-librespot[27425]: go-librespot daemon starting... Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=debug msg="app state loaded" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" 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 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" 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 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" 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 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=info msg="zeroconf server listening on port 41427" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=debug msg="obtained new client token: AACbzlD94ETUNDbNuC/Izt5od2bUfZTqtkv/1bgPUHEknsx45vRzNR3QXLRaFdjyzaEAPsPdyggYrDVUnCaWRXoxykrp9nK1e+ZUnK0VI9WrTI1aGb1NyrfPcBt/M57iOsEcJyAiwCsMSM9mvgm+JPRFUDVI1TkprbaXIloIVcIGe1vHhUESnyZsk2VI+bGHt3ybJS9ckgcaH91/NbiPoH0XDZ6D6HkBaiu0tDnw1MVZvbvfEmENoCs=" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=debug msg="completed keyexchange" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=debug msg="completed challenge" Oct 31 05:37:10 volumio go-librespot[27426]: time="2025-10-31T05:37:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:11 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:37:12 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:12 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247. Oct 31 05:37:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:13 volumio go-librespot[27447]: go-librespot daemon starting... Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=debug msg="app state loaded" Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" 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 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" 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 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" 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 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=info msg="zeroconf server listening on port 34485" Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=debug msg="obtained new client token: AADZhf6sp4tI0slKTFYDQi+UQNY0SbBmEDDXuHDqRrLllvYOOqEOQZLsd6TNE9e2yVtLVjYsUnVwk7C46fmftPVOPzmN63T9/cJqRYI7incoTEBQhSUMmUVaKw5fCtLdOisuPsn3tA3E5Vl7cxSMMsXr2mn4txYHNDv48ZxPNCT+PI8RLxbs1/yuLziwdTDBl4jHxqUN7tJY6fIR5GJbJYpYk76r1xyN6yl0SsrquHPdp3n3RPBxcL8=" Oct 31 05:37:13 volumio go-librespot[27448]: time="2025-10-31T05:37:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:14 volumio go-librespot[27448]: time="2025-10-31T05:37:14Z" level=debug msg="completed keyexchange" Oct 31 05:37:14 volumio go-librespot[27448]: time="2025-10-31T05:37:14Z" level=debug msg="completed challenge" Oct 31 05:37:14 volumio go-librespot[27448]: time="2025-10-31T05:37:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:15 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:15 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 248. Oct 31 05:37:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:17 volumio go-librespot[27455]: go-librespot daemon starting... Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=debug msg="app state loaded" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" 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 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" 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 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" 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 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=info msg="zeroconf server listening on port 38953" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=debug msg="obtained new client token: AACy80nw2n2x/WJ4yly+5bGgbARAzWjmtPrKFeEJzUP0N44lzfsUvQUNRRj3yPz2yikbtnrpiCTRKjsbvqWYF+lDZhcVcjaICVCPEEmlBA44Ea2lpsCWYQ+48L5u/xTGDSYV1OWyLzfJwjPrSQc6OLQUtWTmzmCRYmySFznYngwV8EOzCEDYu1exfK6SCyNgX5lnGxS4h6ZeQvFUgAM6zbnKphbSK71khZC578AOEkRVi7NUlwJORBM=" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=debug msg="completed keyexchange" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=debug msg="completed challenge" Oct 31 05:37:17 volumio go-librespot[27456]: time="2025-10-31T05:37:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:18 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:18 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 249. Oct 31 05:37:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:20 volumio go-librespot[27467]: go-librespot daemon starting... Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=debug msg="app state loaded" Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" 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 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" 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 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" 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 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=info msg="zeroconf server listening on port 39907" Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=debug msg="obtained new client token: AABgr+gz6jmOiHzuZCQCjyvWDxgasSLOBIfQcFxi4zh+JpV0IbKBAlQ2+4REaaogFgSGDv+RDJGuL/09ubddy8g8E5L1I+vlFseSprZxzkBoqvEXVL5Zs4KqmyJn5VBg9fdv6XhU+A2cTeVPcxx1ThJWbWJOCTm9kwGrvCrO0i2hnlU71Ghua2Hljfi1GjNXpNkA+/7L/cEtuRzCiqLWkGCWWJDn6A2s0LAEIVUlZj5RhjdCpszoPEM=" Oct 31 05:37:20 volumio go-librespot[27468]: time="2025-10-31T05:37:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:21 volumio go-librespot[27468]: time="2025-10-31T05:37:21Z" level=debug msg="completed keyexchange" Oct 31 05:37:21 volumio go-librespot[27468]: time="2025-10-31T05:37:21Z" level=debug msg="completed challenge" Oct 31 05:37:21 volumio go-librespot[27468]: time="2025-10-31T05:37:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:21 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:21 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 250. Oct 31 05:37:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:24 volumio go-librespot[27489]: go-librespot daemon starting... Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=debug msg="app state loaded" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" 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 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" 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 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" 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 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=info msg="zeroconf server listening on port 42907" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=debug msg="obtained new client token: AABCBSX2jI54ik/yodJAkaERhSjpRbt+23F1b9zABB0EH0Ktz30oITRlJzAiUK4B2o+fAmzYys5i62Gi/yLb8OFQUk8eXv3/HnNrL1QpbJN7FtDzE1dUoumhHXl5JyOITOzYjK5TYixdTT1E9iEIp5KpOnmCuIXzyg/eMwopHftggmvHZGUDrTWASxHV/czxcTO/9N6iH66x51/aVk5GkHP9g5dY22cdL4650RqiIXpdoH91tsw9DA8=" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=debug msg="completed keyexchange" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=debug msg="completed challenge" Oct 31 05:37:24 volumio go-librespot[27490]: time="2025-10-31T05:37:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:24 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:24 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 251. Oct 31 05:37:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:27 volumio go-librespot[27497]: go-librespot daemon starting... Oct 31 05:37:27 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:27 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=debug msg="app state loaded" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" 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 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" 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 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" 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 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=info msg="zeroconf server listening on port 33799" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=debug msg="obtained new client token: AABd4uhdvUODR9nIdEGtbdbmSQsd4d/t4yFHS1dQc4/tw3ycQ+W/Sf6LtXyXRdFcCZ4pnMkUaTKzbEoGEjezPYslO8rmnwzVhrOdGArTFiws38dfvvKrxr/zY/yCrWtrMHuAx6p12C3MLoqQ7Bgaa6IKZzOhzSmLWrRKIpxWYGnM5x3pnhro+ZJ3CqyHXEKsx69COfI7Gnkw3nOJG9TXE2WguLyrltK0F3OzFQ6HD3KofOX4p6ptsuQ=" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=debug msg="completed keyexchange" Oct 31 05:37:27 volumio go-librespot[27498]: time="2025-10-31T05:37:27Z" level=debug msg="completed challenge" Oct 31 05:37:28 volumio go-librespot[27498]: time="2025-10-31T05:37:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:30 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:30 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 252. Oct 31 05:37:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:31 volumio go-librespot[27505]: go-librespot daemon starting... Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=debug msg="app state loaded" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" 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 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" 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 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" 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 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=info msg="zeroconf server listening on port 40133" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=debug msg="obtained new client token: AAALOHunA+DXoE8UAGcM1o4FPgUHk3NDwVn8LhmYHm6NLoIoLXhrPM3bPMmaueWT55EGcUMP/AbQw5DLpAgQoyJk93v+Mf0M3bbXBa1OZjmryVzdj0j0suXK3xsnahhD39esL7G3JCprJ1Yj1kh945NoWo1Qw/BuSXP3PBxZtYMTRb+lB5GI1tdzPvvvIeQYln+Gw0NxOslq4XsWhbE/CJuyRxNF+V7DyIvac9BwPK83JAXuWleB9EQ=" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=debug msg="completed keyexchange" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=debug msg="completed challenge" Oct 31 05:37:31 volumio go-librespot[27506]: time="2025-10-31T05:37:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:33 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:33 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 253. Oct 31 05:37:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:34 volumio go-librespot[27527]: go-librespot daemon starting... Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=debug msg="app state loaded" Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" 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 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" 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 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" 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 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=info msg="zeroconf server listening on port 43781" Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=debug msg="obtained new client token: AABs70IC/Yv1Rin3HFGNPbvpW/tb4t3gztNsrvtrbSGlqGizodpSY4pjbVIFFaJYNGHwxz6CIYxvmFtRqnpzlllnva9JA2vZOWb1vXXWXE4LBzAx8HyyGbfS26YaqowKypuh+/EX7DeKris6dNtH1yEmRn12Q7NpKkXqjp6NQGkiL/hndLqFjTASEegTtaqzOvS5j2PCjo3xGtxyelKgv3/oSMc8Banno34ovGcSofwPyn4Fp+0w6k0=" Oct 31 05:37:34 volumio go-librespot[27528]: time="2025-10-31T05:37:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:35 volumio go-librespot[27528]: time="2025-10-31T05:37:35Z" level=debug msg="completed keyexchange" Oct 31 05:37:35 volumio go-librespot[27528]: time="2025-10-31T05:37:35Z" level=debug msg="completed challenge" Oct 31 05:37:35 volumio go-librespot[27528]: time="2025-10-31T05:37:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:36 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:36 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 254. Oct 31 05:37:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:38 volumio go-librespot[27535]: go-librespot daemon starting... Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=debug msg="app state loaded" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" 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 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" 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 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" 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 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=info msg="zeroconf server listening on port 39693" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=debug msg="obtained new client token: AAA7Iuh8ZbUjom7XQWr4o1/Qa1HU8z9r3Lp/woYkk0ckxbJEB83Cr+cRH8p5+n34H+yYtGVRU1RdE/phjd1EdVkl/9AKvhOKyhc8GvAnkhcPpofEaIDF8wk1cfBKHKkIzaFHD8So1jVLnf797JTruERge34XC5pzNEJxuvcV3905052T3rWclPTjpYZ+Z0dduxHJUhjvC5aW05vY2Se3Gs9LenYu/l5CH6pPPTyUCBx4RKjVcsT4S8Q=" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=debug msg="completed keyexchange" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=debug msg="completed challenge" Oct 31 05:37:38 volumio go-librespot[27536]: time="2025-10-31T05:37:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:39 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:39 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 255. Oct 31 05:37:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:41 volumio go-librespot[27547]: go-librespot daemon starting... Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=debug msg="app state loaded" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" 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 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" 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 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" 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 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=info msg="zeroconf server listening on port 34919" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=debug msg="obtained new client token: AAD/+f916yMDaWzJ19pRcKIT89O+DNHh14XDeC2Oo55h2O0sZ3M8OKydJialCyaN3M1ldKuVU8Ev/2TLgbBaiIc2b4At2IBb4PgUwaui2vAOiaeQcEclXntLtQ2DXitTRbRvKThqFIviZiS8x1y/qUQMa6p2Akljd20MPZYwNOPlOX60G86AnRdTxRSWx+7WorWRY0JI7vNHNl3nEONLGyUfQgimgPDPG7B+O4y0IxkXgnrTfIqJ+LE=" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=debug msg="completed keyexchange" Oct 31 05:37:41 volumio go-librespot[27548]: time="2025-10-31T05:37:41Z" level=debug msg="completed challenge" Oct 31 05:37:42 volumio go-librespot[27548]: time="2025-10-31T05:37:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:42 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:42 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 256. Oct 31 05:37:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:45 volumio go-librespot[27569]: go-librespot daemon starting... Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=debug msg="app state loaded" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" 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 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" 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 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" 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 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=info msg="zeroconf server listening on port 36103" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=debug msg="obtained new client token: AADVlmRpIs6/5EgA9NM9S7LJ7T6LGoFq1JIr9jwe0TQSFQVZHhV5HrzYAXFHKolj/0SqF3wYTjSXTFi4tP56u5HBwn18D3EXhz5ML4siUZbOF3EvNjXsOs7no8GkI/Ap0bewqIjQtRkeI0vcWDV0+iYYbUzLIPXE/atKoVCju69WQGtGYVkfpYN65y0M99t+zHlwZDy50okgtnBHfGI02V1eOWWpVzWtzRM1A28iCXfTY+NiSL90EO8=" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=debug msg="completed keyexchange" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=debug msg="completed challenge" Oct 31 05:37:45 volumio go-librespot[27570]: time="2025-10-31T05:37:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:45 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:45 volumio volumio[26423]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:46 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:37:46 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 31 05:37:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 257. Oct 31 05:37:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 05:37:48 volumio go-librespot[27577]: go-librespot daemon starting... Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=info msg="running go-librespot 0.4.0" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="app state loaded" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 05:37:48 volumio volumio[26423]: info: Initializing connection to go-librespot Websocket Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="new websocket client" Oct 31 05:37:48 volumio volumio[26423]: info: Connection to go-librespot Websocket established Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" 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 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" 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 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" 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 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=info msg="zeroconf server listening on port 45421" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="obtained new client token: AABJPBA0x/PMpHpvMd2KLNrG0jbBWSYUefjW+Q+l+zR6iIw757CWixPyRpDYYTGPjGeearmSWdK5W+Qf+UVB5gv6T3Z6+Gcsa+RdZtKVafUPRXexJrcu3sm+MgCw9xoDkbK1jyiHSUUBa2M9YM2OWhEa6xfqiX7MYzn+zRjaeObbaeCRZ5ZNHeXgoEu9ngJXcxREUtVkCIA2jZfsSdVOTX/sUiwP0tidtpy2JrNb4hK0oTpYweKW0gU=" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="completed keyexchange" Oct 31 05:37:48 volumio go-librespot[27578]: time="2025-10-31T05:37:48Z" level=debug msg="completed challenge" Oct 31 05:37:49 volumio go-librespot[27578]: time="2025-10-31T05:37:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 05:37:49 volumio volumio[26423]: info: Connection to go-librespot Websocket closed Oct 31 05:37:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 05:37:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 05:37:51 volumio volumio[26423]: info: Getting Spotify volume Oct 31 05:37:51 volumio volumio[26423]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 05:37:51 volumio volumio[26423]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 05:37:51 volumio volumio[26423]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 31 05:37:51 volumio volumio[26423]: errno: -111, Oct 31 05:37:51 volumio volumio[26423]: code: 'ECONNREFUSED', Oct 31 05:37:51 volumio volumio[26423]: syscall: 'connect', Oct 31 05:37:51 volumio volumio[26423]: address: '127.0.0.1', Oct 31 05:37:51 volumio volumio[26423]: port: 9879, Oct 31 05:37:51 volumio volumio[26423]: response: undefined Oct 31 05:37:51 volumio volumio[26423]: } Oct 31 05:37:51 volumio volumio[26423]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 05:37:51 volumio sudo[27600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-31 05:36' Oct 31 05:37:51 volumio sudo[27600]: 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"