Nov 02 16:44:02 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:02 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Nov 02 16:44:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:03 volumio go-librespot[7277]: go-librespot daemon starting... Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=debug msg="app state loaded" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44: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]" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44: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]" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44: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]" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=info msg="zeroconf server listening on port 37769" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=debug msg="obtained new client token: AAAZQ/xyiPTBFAw5kFIP+LO874Qwo6aHit/WSsULdlpB1JDhD1goYZedom6VjqFBaeDB1isq7iadEgZcPLrgOFU4fVNDaXnirJiLtuqJ6ayi98Nubuo/R8cT6HxPwQ1cuOkfG9YdBLjDkJkRGuCP9Ir48KlJJ0GCCY0yT76DJAItUHvM2r/x34v/BTRrJi1y6U2EOUBXtOCOuJTqqBeJoNXLJ247jLn+4N9qzEyYmIHdRpqQEBq4" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=debug msg="completed keyexchange" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=debug msg="completed challenge" Nov 02 16:44:03 volumio go-librespot[7278]: time="2025-11-02T16:44:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:05 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:05 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Nov 02 16:44:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:06 volumio go-librespot[7302]: go-librespot daemon starting... Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=debug msg="app state loaded" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" 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]" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" 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]" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" 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]" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=info msg="zeroconf server listening on port 36413" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=debug msg="obtained new client token: AABZKRq67Knj8leWAHz3yAgHQs5o6376j8Ffise+egRl2lc2CyBuxZmcFCV6+PRj//rkXlCLXVQvPGmvh2shX4AAeCsgBDY9smL9AXJJejMfOqcN3hUsGxGAIBomZLHRKHc+ypTxGouS5dP12dfo1a8yW0Npa+OajMfZK0ORu+xek9TYh/062kf974/08M0biKlBgfWuWDdIXJS9vxMfLyduQlDeZLRe/C+aPMpPbLyGAyyjH7XftrA=" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=debug msg="completed keyexchange" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=debug msg="completed challenge" Nov 02 16:44:06 volumio go-librespot[7303]: time="2025-11-02T16:44:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:08 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:08 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Nov 02 16:44:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:10 volumio go-librespot[7310]: go-librespot daemon starting... Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=debug msg="app state loaded" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" 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]" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" 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]" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" 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]" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=info msg="zeroconf server listening on port 39379" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=debug msg="obtained new client token: AABo31EWcEuAIOAZ1zICghuXvxssaacfk+5fXR91Nvt9/RkFevc7U3q/SIAoRdDe4MMp40PfqPYHy9CeBZ4dp3eweV6mhVjxDfNtPl4CqRQrPUXKc4JrU3h+JuOuiqqMoLpvbyKQnOKIJAPr+Zi9TiV3U9stgCJoYVLp+S3QDumW95g4SmYuxtzlFEe8v0JTUMOjFGNdqHspKNhHgFlC/7D+kifpo8bnrXNK4lLlNPGAiVrf13oK" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=debug msg="completed keyexchange" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=debug msg="completed challenge" Nov 02 16:44:10 volumio go-librespot[7311]: time="2025-11-02T16:44:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:11 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:11 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Nov 02 16:44:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:13 volumio go-librespot[7318]: go-librespot daemon starting... Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=debug msg="app state loaded" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" 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]" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" 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]" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" 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]" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=info msg="zeroconf server listening on port 34793" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=debug msg="obtained new client token: AAAz5DeBCRXGNQWDnp83zp2ZW3/Upchd+hGqLT/lQeT8m4YpjYVc36w9AqfWAsGR+srAlEnZ4AH7+NoaB52ShFM2l2TRXIRpcHTMnYmzWITq3zb6Yhc3iy5hPZX+8AnV2QUFiL0LaXK2xBRneDhwuQy4U8UvltSSxlfVAKNY1oHnsK3FQLY5zVc+F2UWArPrdFVncRF8DtCE6J/aeBW6D3AzCaJMlddfzp0hM3s3Vcg3oS/PBQv17eY=" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=debug msg="completed keyexchange" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=debug msg="completed challenge" Nov 02 16:44:13 volumio go-librespot[7319]: time="2025-11-02T16:44:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:14 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:14 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Nov 02 16:44:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:17 volumio go-librespot[7341]: go-librespot daemon starting... Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=debug msg="app state loaded" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44: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]" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44: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]" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44: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]" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=info msg="zeroconf server listening on port 43551" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=debug msg="obtained new client token: AAC0d020B9FOzRnf6fB06vhfDD8zORxmvut5iAyBsmKMzqStTaXiCsMpMJs9ycJjFyDKi5dUN77eOwpVEqpG+d+XzNLjA/k9DcWNzmzqXf4MfwofGetqJs1zO1zVyjBCDBW4IrO7ckUA3ibxWywwVekNvHC/t6qtkj82/veoYnCFWB16EoONXuCHmGaEdPig7Jh52AiDSWKOVEQnBKsjrdygygQnbC2Cqc1VLyIlCUfifIue+54K" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=debug msg="completed keyexchange" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=debug msg="completed challenge" Nov 02 16:44:17 volumio go-librespot[7342]: time="2025-11-02T16:44:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:17 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:17 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Nov 02 16:44:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:20 volumio go-librespot[7352]: go-librespot daemon starting... Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=debug msg="app state loaded" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44: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]" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44: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]" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44: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]" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=info msg="zeroconf server listening on port 46783" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=debug msg="obtained new client token: AAAHerCBb13VGcIzHouEWxyqn2E2ZY3MFxY34vN2HFKkIOjtXjIhANMql+CnfcDG3C1pFc0S9rD7xqJHEPYSdegfOUE8RFIQHN8+7LoJsZtv084uuzjbIeN1rmz6CIPOu66nXLkEYKvbLHc0ATReGLz0twxY3GBYYUq4XHxOXlHaIw6poxnrVNhoPeMmSm/8sLFZ5+Edg0gFRgkMHMQh+MaSkMOgrZ0y1+3o5MCRziXphuIKm15kchg=" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=debug msg="completed keyexchange" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=debug msg="completed challenge" Nov 02 16:44:20 volumio go-librespot[7353]: time="2025-11-02T16:44:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:20 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:20 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:23 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:23 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Nov 02 16:44:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:24 volumio go-librespot[7374]: go-librespot daemon starting... Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=debug msg="app state loaded" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" 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]" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" 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]" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=info msg="zeroconf server listening on port 44519" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=debug msg="obtained new client token: AAAKBoJfrDOW4cogWxTsg+m3Kw6nHUhVdh0gEHmNhUbz6RhghjOPT+NH9PTD1FopH7mI1BCi/sDTO1bCdYdui4FwaSPlgIY7hxHT7/2fInbOHhA1/SuL8nucBNBuTPeqj5Lj09ggM9Ct2pZ47qdAZe2MD2eC/NXXiCkbGPGCYwarViOnnHPqgecuSkhyEKCXs7jufjHWKU8WfKjtID5q7kAfJZPjSSyY5khlFxlGdosyulDUYgd3" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=debug msg="completed keyexchange" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=debug msg="completed challenge" Nov 02 16:44:24 volumio go-librespot[7375]: time="2025-11-02T16:44:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:26 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:26 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Nov 02 16:44:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:27 volumio go-librespot[7383]: go-librespot daemon starting... Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=debug msg="app state loaded" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" 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]" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" 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]" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" 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]" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=info msg="zeroconf server listening on port 41191" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=debug msg="obtained new client token: AABl9nyakhjBuegwQoYJQ+6MyY628aS0Wu0HMfntnKT5I0qcJkuTqwbogNCJNKz6H85fjayKOXjLHuGpNiRGeoX6TPPabTax/R1fjQ1FxTo/rFhFbbsE4AskKSEe1cGPAJcpz8YAQg58KDAhZAAr1KeG3+wmOu7CKcH8ePL9bIU4VlN2dPOVyGxUKMZe6qchpbcs4ZLPJhvbBQZ/8UTRnIxxRqdxsR8aw/1rGy4iiBPDDVglH+R5y98=" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=debug msg="completed keyexchange" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=debug msg="completed challenge" Nov 02 16:44:27 volumio go-librespot[7384]: time="2025-11-02T16:44:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:29 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:29 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Nov 02 16:44:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:31 volumio go-librespot[7391]: go-librespot daemon starting... Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=debug msg="app state loaded" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44: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]" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44: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]" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44: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]" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=info msg="zeroconf server listening on port 38131" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=debug msg="obtained new client token: AADcWSPatonAwF3a23SEf9kl99qL5RfY07v2SiMzndzgCXGVHZY/HfQsgtmm/sCSH4vsmLaNRBPpovIz+rvPbf2QeuXbnRRNQZcl9r+LfG/BSAMscbysceBcj6x7d37tyr1liLx4XY4hrwq+iLgB4oXQziW5joHy7hY5qH7TkmfuQ2+zRfH31EDErSlSImN86xxDW29/SqMG0xFJIPBr9VHu10DTzc9t7NPQN6X1ZUh5W0LVXHZE" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" 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" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=debug msg="completed keyexchange" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=debug msg="completed challenge" Nov 02 16:44:31 volumio go-librespot[7392]: time="2025-11-02T16:44:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:32 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:32 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Nov 02 16:44:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:34 volumio go-librespot[7413]: go-librespot daemon starting... Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=debug msg="app state loaded" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" 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]" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" 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]" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=info msg="zeroconf server listening on port 39837" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=debug msg="obtained new client token: AADdxsLGQTSQ+1sPz6tDt9Qz+bKv/l3QWtrb5rOAZA4/yO9jMtwb3Xz9nvq+K2ww3oMp08Yf11cxVYUDhFkf9AOlVGZRw4MI9J/GiJ3NTFwbiGv4HMwus9W5mN5uXfMGu30Ou/+ThWqlSnTT5Glel7xHXKxp297uK3/3ik0NSo4pWVqqs8oS9rXLQY7wKpY/zj8fNo8fzQQQaPxxdgLUJED1UTPIAo3d8YsiQRFfTJbOLVPZlXe/h28=" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" 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" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=debug msg="completed keyexchange" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=debug msg="completed challenge" Nov 02 16:44:34 volumio go-librespot[7414]: time="2025-11-02T16:44:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:35 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:35 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Nov 02 16:44:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:38 volumio go-librespot[7421]: go-librespot daemon starting... Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=debug msg="app state loaded" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44: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-gew4.spotify.com:80]" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" 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]" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" 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]" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=info msg="zeroconf server listening on port 38947" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=debug msg="obtained new client token: AABlgwD7xYuzRdtIrVx/MyURsQ3td4eWUgcpybqdOmuoc1uhArxTZP6Tyufpm1tLGcmQJYfGcu0mVTAKqCMEeOyChsXdl0fWXxZkHgBBudl+xrzYg9k2huzQIqMftkOGaneYnosJu9PH7CZGUW4Muj8aZbRl+ffpeg9p166ZxDgTfjBOYZKvOTFx/mKOWsDRSrLKKYygG4GyT31cCuzFlkXyqnZ2WSHCemFBaIx1wGSdOxxRobPJ" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=debug msg="completed keyexchange" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=debug msg="completed challenge" Nov 02 16:44:38 volumio go-librespot[7422]: time="2025-11-02T16:44:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:38 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:38 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Nov 02 16:44:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:41 volumio go-librespot[7432]: go-librespot daemon starting... Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=debug msg="app state loaded" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" 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]" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" 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]" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=info msg="zeroconf server listening on port 35313" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=debug msg="obtained new client token: AAAXjBpv42tKkvfqX8TtDR+Q7qSkL9/HqF9tlFqmQ03UKClCXS6C4Kx8e/tvRRJodB/aBXQKYxN7iud8eP5i8JdhQ6F0H3+9u7Ear1GkdSWvlFNFUM3l90yhAVkB4D7Ju7I+RvBlTZ/RZNhmN/oPCAsXrbya19YQc6/tUko/UxIP+sXuETHPOZSgOLfn3XkbojA0hEi8p6qBgo1MuqW4nZxnb4XemnXglBlhdQWWEozyvUiD4t9M73s=" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=debug msg="completed keyexchange" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=debug msg="completed challenge" Nov 02 16:44:41 volumio go-librespot[7433]: time="2025-11-02T16:44:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:41 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:41 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:44 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:44 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Nov 02 16:44:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:45 volumio go-librespot[7455]: go-librespot daemon starting... Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=debug msg="app state loaded" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" 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]" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" 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]" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=info msg="zeroconf server listening on port 36945" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=debug msg="obtained new client token: AAB5w8M08TvoBGGOoEy7QaYH67G4M3niyvHqoBZJ1RYQ7HSa/g874vz1I+fis6ai7bhKU5czoB3dhf59e88qDBEdaRV3wKQX/8l+7lY8mHKQkO0Z76zE9/Y1uMuziam7fq2YSCZQSSK+xsHbPJDzESBLf8JyIVQDKkiD94a5Fw2lnQ+MOdmD2nfiKCXJRLgr0FxXEBEko/DdvuPfogpYrCut3AgG3db80Aqm9hJa1Cr5zqm8MysD" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=debug msg="completed keyexchange" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=debug msg="completed challenge" Nov 02 16:44:45 volumio go-librespot[7456]: time="2025-11-02T16:44:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:47 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:47 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Nov 02 16:44:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:48 volumio go-librespot[7463]: go-librespot daemon starting... Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=debug msg="app state loaded" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" 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]" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" 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]" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" 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]" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=info msg="zeroconf server listening on port 36805" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=debug msg="obtained new client token: AAD3hoovq8Agk5iTZXf3ojJx7AW+EMXGbMPsR+a/JArwL+e1plBR6TvdAx27ksFNtnDVDqCi9Aeo8EOjy4HqDX1ywlx4+cJC87pj/Iz7AB60ZW+wnsuiq5O5+HBM3c5Yd6rw2OeqaN3nbt6GcXQtZ8dwtzuEykcfpsHZ5C7HbOpy6V7+isWIB1hnwLrreysMJaa3amJRo5k/+aY469x3CCfz3dXpZ6Dqo0jJdAgLfS3HVTwRaprlCIQ=" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=debug msg="completed keyexchange" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=debug msg="completed challenge" Nov 02 16:44:48 volumio go-librespot[7464]: time="2025-11-02T16:44:48Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:50 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:50 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Nov 02 16:44:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:52 volumio go-librespot[7472]: go-librespot daemon starting... Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=debug msg="app state loaded" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44: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]" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44: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]" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44: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]" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=info msg="zeroconf server listening on port 46459" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=debug msg="obtained new client token: AAC/j2zjbbZE6jfLe8qV06hO3oIOut+iQChUFq7CM/ISiQWHa6a3fpBs7ocZTYLAeMG0RYxSi56k3Co2z5DRJIPLl6Iom9tkuSnNk8Z4JsR5vYv2f7hQ16zwXypfIa1n/IXtwrBEmcCbe6jp3deaY2t3CIC6ohJSQ5nqt/azFHLnzOXqLF6FCKLGg1Qvx8LvB6C+AU/2fjRkHhvKekQ6VCxCP1DLVolFaZRKvG0Nqync9VXkVzjY" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=debug msg="completed keyexchange" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=debug msg="completed challenge" Nov 02 16:44:52 volumio go-librespot[7473]: time="2025-11-02T16:44:52Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:53 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:53 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Nov 02 16:44:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:55 volumio go-librespot[7495]: go-librespot daemon starting... Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=debug msg="app state loaded" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" 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]" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" 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]" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" 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]" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=info msg="zeroconf server listening on port 37639" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=debug msg="obtained new client token: AACYTl4UhzsJAVMGSEKVT+Uuy84vFnhXPbkKxxRwle3FNbcxOwbOMpiFVdrBql6LSAJfbs7yJoWiuV/inhmuyKrzgsMei6lmxLcLy3ZRplGCtZCM13H/i2ktZ3klyIpg7hMSDukDd9zxSLRm6pViSWo5G+FinKUtHNpu+JVymrpuDCkp/AAJtubToqjLifpXXhKTQRP3eDnnCRc1Tc7Ke+0nDuIIbMT47hHI3LCOB+gKa9VoxWQcJ6c=" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=debug msg="completed keyexchange" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=debug msg="completed challenge" Nov 02 16:44:55 volumio go-librespot[7496]: time="2025-11-02T16:44:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:56 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:56 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:44:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Nov 02 16:44:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:44:59 volumio go-librespot[7503]: go-librespot daemon starting... Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=debug msg="app state loaded" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" 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]" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" 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]" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" 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]" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=info msg="zeroconf server listening on port 34171" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=debug msg="obtained new client token: AACey2nVGkZVggzp49jVedoOBcQOXaWtZtMiFuoW0vP9kb2VQTCU69sQ0MSBpH8CAVaMy6KzsQcNQcV1m3T2C+mR41In+bi8ns47Bar1276l5XyE5F2OQ630XXviWaFMQxRtvd7A+ZJxB6ANt6Sg6exBKWKoHn3YQHVY2UXkCCutZI5LQKuILT/qCJJ9YdzAjyeHMQ4JQAfuReEeLrKTtpe4PvWHby4TXZkYtc2kWMS/8BZ7j/wB" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=debug msg="completed keyexchange" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=debug msg="completed challenge" Nov 02 16:44:59 volumio go-librespot[7504]: time="2025-11-02T16:44:59Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:44:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:44:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:44:59 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:44:59 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Nov 02 16:45:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:02 volumio go-librespot[7514]: go-librespot daemon starting... Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=debug msg="app state loaded" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" 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]" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" 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]" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" 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]" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=info msg="zeroconf server listening on port 45881" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=debug msg="obtained new client token: AABd1PfieUfPpjdX8ziVt1WsgKrJAmzTH76lQ9LwfUb3T/MM7kw1SlqpdEKKPe+jk4UF/QXu0yExrWWchRbeWIrzQIwG9zsEoA3jHh8o1L7CiE+maiUjk32SH5T/2H/FHTdJh6bp+pz2Egex9Pq7H7zpF6fZlcgOL6N/mrooDBrWzO9z9msdLkMYYFbS6YPwneJF6/NuR7NZJzU/1HX50sa/fbsr0eFohMfO3cRl+QDHqQ9EdhIsWsU=" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=debug msg="completed keyexchange" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=debug msg="completed challenge" Nov 02 16:45:02 volumio go-librespot[7515]: time="2025-11-02T16:45:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:02 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:02 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:05 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:05 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Nov 02 16:45:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:06 volumio go-librespot[7538]: go-librespot daemon starting... Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=debug msg="app state loaded" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" 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]" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" 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]" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" 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]" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=info msg="zeroconf server listening on port 40211" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=debug msg="obtained new client token: AADBDZnrp4lZjK9Fv7r0tpOA9wU30D6uUe+HG4zg4gFkUyud4YQTqw+LzNlKNQiDKmNpiRKLEtPT6O+++y/O2dBTDS8KaPocIcDewrzetd6zG9HnmDgKkJ68GYun6TkH6StIn+BrLuZzABVx19mxn2EPsgny+iFOMR2z5dabfxhYnRAiYJhi48UsllpACk2jbBtYncS79tksYb5Dxu7Ty1D+zOUa3ZnaAKG98brchy8zsUWuefrz" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" 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" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=debug msg="completed keyexchange" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=debug msg="completed challenge" Nov 02 16:45:06 volumio go-librespot[7539]: time="2025-11-02T16:45:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:08 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:08 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Nov 02 16:45:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:09 volumio go-librespot[7546]: go-librespot daemon starting... Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=debug msg="app state loaded" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" 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]" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" 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]" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" 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]" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=info msg="zeroconf server listening on port 40983" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=debug msg="obtained new client token: AADC2m+CNor/O669j9SBiOIqYY9L1eyl4yiS3WpMnbalWWoyIm1TyRX969PVEnhZP1TTQrUeMM4uyD4mSQjh4DRms9tVyLdIVB69NS9G72zsaNa4hhyJrsStum2vRdqfTpvvCRklVFT5kBhzg1tiBFNuwkqVB/0DJ18eNeOGiTneokYGMKYMS1Et9UW+FNv+kW070D4h+EB52VUpE7U+Yq3wPtASDrjQZTsQP2DYDy2TmZz46emZzFo=" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=debug msg="completed keyexchange" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=debug msg="completed challenge" Nov 02 16:45:09 volumio go-librespot[7547]: time="2025-11-02T16:45:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:11 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:11 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Nov 02 16:45:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:13 volumio go-librespot[7555]: go-librespot daemon starting... Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=debug msg="app state loaded" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" 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]" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" 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]" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" 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]" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=info msg="zeroconf server listening on port 45239" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=debug msg="obtained new client token: AABLnov2j0RBr2vgZa8TvBCZ8nVVtuc04szp243BIvr7p5yYp4xdlJbzvKK4fojAVd62JkhVlrho2A22Z8pcQ5Z6aQV+a+l0+/5+Ui9R2kdo4CfBzvsPtuHn7a6j2Lut6HBIpmctOZBLgVaquc5slEI8mJ1BxIOxUlbczLXe5+UlmrvtHsxquW/ne1Z4GY2XQ6etNG1ixVDYFFjoru3lm8BBRWZ43T4GviLajHbg9YRRDH7GIpkr" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=debug msg="completed keyexchange" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=debug msg="completed challenge" Nov 02 16:45:13 volumio go-librespot[7556]: time="2025-11-02T16:45:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:14 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:14 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Nov 02 16:45:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:16 volumio go-librespot[7577]: go-librespot daemon starting... Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=debug msg="app state loaded" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" 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]" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" 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]" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" 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]" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=info msg="zeroconf server listening on port 42429" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=debug msg="obtained new client token: AAAGE5yOtH3C2eqQ4spnxwYOSEmG95JWdt1yDw6twsaqars+o3BRZWz0Ghw89/sKPDTSULi+dwnka/VV7oBeDp5bb6SICiiBpLQfWlYnJ6d/XeyKz6uqAExULrKeHb2wSC/ddN9PSj/iCv/0JyK3ov7zQOHXr//UlMgQBQxZraoNXtii9Sa/uE+A0/W1rbuYrf546TkW+E+7tGcWeGvTdlIlvEyAc0xF91PtKO2GuNikHxspk5ehswQ=" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=debug msg="completed keyexchange" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=debug msg="completed challenge" Nov 02 16:45:16 volumio go-librespot[7578]: time="2025-11-02T16:45:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:17 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:17 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Nov 02 16:45:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:20 volumio go-librespot[7588]: go-librespot daemon starting... Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=debug msg="app state loaded" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" 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]" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" 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]" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=info msg="zeroconf server listening on port 44615" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=debug msg="obtained new client token: AACwsYeoULuy3JyD8zm/yRoC/GCmW/5e9XQkDmaS6FRzZmsEmC2Yb9eBlrKYWepz0MDDVdcxdxSdEVIbXYCRGQRo7h4jr5pEj9Kgxp3RknuB9n3L2zQVPmErGh3DbNVBR/ipQb2K+8AYaj1akKoiAVVeCbcqKznXccbuLfkkmnIhQyb4E3shEfXa1dP5s8GLFYeyqLekuagZgmSYDPJcwrjhL02ruq7dMvr5Ki8ps3mNYbTI6W8+" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=debug msg="completed keyexchange" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=debug msg="completed challenge" Nov 02 16:45:20 volumio go-librespot[7589]: time="2025-11-02T16:45:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:20 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:20 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Nov 02 16:45:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:23 volumio go-librespot[7596]: go-librespot daemon starting... Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=debug msg="app state loaded" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" 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]" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" 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]" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" 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]" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=info msg="zeroconf server listening on port 38835" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=debug msg="obtained new client token: AACxRRXibRm3f+hh2VEMpkPxRAd2Qh6ABU0uavwbFxpELT9GwTwNP1YqPWRxo+4HUTFpB73Bf+rXv7KzxPDLbOUYVZatpf8fuS3DdpDN3Vh85gu9yXfre9qxKzd3QdSMkrBm1QuDXuWelO40xgexrDgsLgAMiduilMjN+hUkC/jlfgErt+hz8kC5vVmW1gZSQ1QtW/giI3WtuTnkUMjXbPAgeS0rsSMD1l7pcOKKWhqW/yl2WOSmjXo=" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=debug msg="completed keyexchange" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=debug msg="completed challenge" Nov 02 16:45:23 volumio go-librespot[7597]: time="2025-11-02T16:45:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:23 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:23 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:26 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:26 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Nov 02 16:45:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:27 volumio go-librespot[7619]: go-librespot daemon starting... Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=debug msg="app state loaded" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45: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]" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45: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]" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45: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]" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=info msg="zeroconf server listening on port 40293" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=debug msg="obtained new client token: AACZqp9OahoffW9VzPvd+2bv4jRV+FbgJPk2yW8E7nYBqL+tZdmNb1ClysPUy0XjrAsmEcrFtYHykx0GYGSGqbPz+g5MAfwK+DG8wqrMrP6jnJ8qO4OSImJyZwx4hgkzbpa3wDSGs7+iJCQgq/MRAogyh1OrF7gm6mNNXaiJsVbR9HRk41EnCqohehg6dP0xsPO5sKmPqIJaela1kXwGMdiraVZwPyPD6mleooOREQ9N+AaDCqmg" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=debug msg="completed keyexchange" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=debug msg="completed challenge" Nov 02 16:45:27 volumio go-librespot[7620]: time="2025-11-02T16:45:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:29 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:29 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Nov 02 16:45:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:30 volumio go-librespot[7628]: go-librespot daemon starting... Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=debug msg="app state loaded" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" 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]" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" 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]" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" 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]" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=info msg="zeroconf server listening on port 44083" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=debug msg="obtained new client token: AAC5orbcA1PK3fqG1Uy0jFEb+mJfIPWzdgm6WfB/rwMIdovsLxPfsk5cC9JXN93LAohNtYtVKuJutkENE0tcnsW79kmi5xv3yx6S8TvgHR0EjFpf5LvsK43pTmxs88ez4zOcVvilp/6oWD8zG0ZZoQrE0+7vCYL0igK5McLTFiKXl9yzBghR076FpnWFciJds+2s7yv4TyDW0NAtnNfqAKjc8Nn/KRWBBeTBStdKLfo6VylRbmDzF+w=" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=debug msg="completed keyexchange" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=debug msg="completed challenge" Nov 02 16:45:30 volumio go-librespot[7629]: time="2025-11-02T16:45:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:32 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:32 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Nov 02 16:45:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:34 volumio go-librespot[7650]: go-librespot daemon starting... Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=debug msg="app state loaded" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" 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]" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" 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]" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=info msg="zeroconf server listening on port 34285" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=debug msg="obtained new client token: AABgvdP0EgkYAz99Hkq+6DkGEGcu2jlHB3YzntkkkdcNyQpUstsAz1v9CZv1oNU060UhLCr25InQKhtG26PlNYBjvD9Qzl5k4EGrt3klLeMr9GM8d5x500rIv8F7gecvknuwZwhQxNe+5EX/QKeX9T1Vg9R+hVQ64vfbZpGAAvA7BTEMEJPP8tCxsfQO/reAB+m1gg4MO34qfjOKKsysSi03WYQVRiETyWZxWkel0WeDz+C4Isd9" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=debug msg="completed keyexchange" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=debug msg="completed challenge" Nov 02 16:45:34 volumio go-librespot[7651]: time="2025-11-02T16:45:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:35 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:35 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Nov 02 16:45:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:37 volumio go-librespot[7658]: go-librespot daemon starting... Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=debug msg="app state loaded" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" 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]" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" 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]" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" 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]" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=info msg="zeroconf server listening on port 37795" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=debug msg="obtained new client token: AABm/y8U3VE5w81+2W5w8hUsexzMZ3UMRKj6OhnsnOzDxaJ8F4Lyvjrq2HODVxvD/H0vzpL38ZsEmQUx856yTHiqA0eqmxQ7oJ3FqlPxHws2M8rdU4whG1v8ZsH1AYLJQQIEiePbHsJ9jNL0ASFCyc3uz451YAWNa1f9RWa1uDRfeSjNG7j1S3XhSHPAf/d7KT1y/YBS5aGBe2DvzGD50pQYXeyJ/PHZFKV1OTGps0jnUbARYNLeEWQ=" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" 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" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=debug msg="completed keyexchange" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=debug msg="completed challenge" Nov 02 16:45:37 volumio go-librespot[7659]: time="2025-11-02T16:45:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:38 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:38 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Nov 02 16:45:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:41 volumio go-librespot[7669]: go-librespot daemon starting... Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=debug msg="app state loaded" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" 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]" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" 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]" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=info msg="zeroconf server listening on port 35223" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=debug msg="obtained new client token: AADf9Pf9B0vWAGDF5YMbkFEsLkyiDynGRqFx8IgYW5hppWIH4jAeNCn3ytQYwy30y3TMXyR8TJ41D4NTA4+n3n5ZGs09UxvBXDHdvyJrlDcsfl+fU1+Kfr2i9YvdlIoDIikFxjy+gHdK+QEw1irhDs/CEOr9BkoVhkdzNGYrxX17UmeuJ9v/Mrbzgt5B1RfbVzy15O6j3W7/Ns82qbBp9+2DBguYzQ4Gw4Y9zw0kqEKacYkWR5n8" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=debug msg="completed keyexchange" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=debug msg="completed challenge" Nov 02 16:45:41 volumio go-librespot[7670]: time="2025-11-02T16:45:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:41 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:41 volumio volumio[6623]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Nov 02 16:45:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 16:45:44 volumio go-librespot[7693]: go-librespot daemon starting... Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=info msg="running go-librespot 0.4.0" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="app state loaded" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" 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]" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" 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]" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" 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]" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=info msg="zeroconf server listening on port 42683" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="obtained new client token: AABu1sWEIZbJo1XFxf1svSr+VFIUjx+l7i8KtrFM8st/hLWYLC9t+zkBSHyhuaFHsgVkX+zwvifPiMPbqry7T1pXBXoUFmkRqQYTfG9AcEAag5dAtyIPIRpe+z2Ah56mPHUG1yMGftWczACe0uAuxFr/bYfBdk+ASnmaVKkyo3AFVbgmn1VQicKi8nTGp7JOia9pXj9S2f0sESsOaC7EM9FzRUxQ0dUtIQOERzZZfNA9rwTnc26sFP4=" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 16:45:44 volumio volumio[6623]: info: Initializing connection to go-librespot Websocket Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="new websocket client" Nov 02 16:45:44 volumio volumio[6623]: info: Connection to go-librespot Websocket established Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="completed keyexchange" Nov 02 16:45:44 volumio go-librespot[7694]: time="2025-11-02T16:45:44Z" level=debug msg="completed challenge" Nov 02 16:45:45 volumio go-librespot[7694]: time="2025-11-02T16:45:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 16:45:45 volumio volumio[6623]: info: Connection to go-librespot Websocket closed Nov 02 16:45:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 16:45:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 16:45:47 volumio volumio[6623]: info: Getting Spotify volume Nov 02 16:45:47 volumio volumio[6623]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 16:45:47 volumio volumio[6623]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 16:45:47 volumio volumio[6623]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 02 16:45:47 volumio volumio[6623]: errno: -111, Nov 02 16:45:47 volumio volumio[6623]: code: 'ECONNREFUSED', Nov 02 16:45:47 volumio volumio[6623]: syscall: 'connect', Nov 02 16:45:47 volumio volumio[6623]: address: '127.0.0.1', Nov 02 16:45:47 volumio volumio[6623]: port: 9879, Nov 02 16:45:47 volumio volumio[6623]: response: undefined Nov 02 16:45:47 volumio volumio[6623]: } Nov 02 16:45:47 volumio volumio[6623]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 16:45:48 volumio sudo[7715]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-02 16:44' Nov 02 16:45:48 volumio sudo[7715]: 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"