Oct 24 14:16:00 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:00 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 205. Oct 24 14:16:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:03 volumio go-librespot[15741]: go-librespot daemon starting... Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="app state loaded" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=info msg="zeroconf server listening on port 45819" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="obtained new client token: AAA52Ts6xV5Kfd5fFbBdSOO5JWWMhoUruuqg43p2iynDjjoGHA6NpE74WLqxJZzZQx+Ks00U1qYzvsFrMpO1XwylOI4cF6NPCjcFer79v6Acccpmo1JdadsO/Z1/N94fdoHXy0gLavIrJXjDM0R1jU8jmnSSz92UJLXZ7c66HBJb4DlqTS6SbhpfwKTtPEJH2SAJR1Iglm3ikZfwusaKPpB/JU9JdnGN3zMNpkI5V4p4Z65au3XBpDc=" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=debug msg="completed challenge" Oct 24 14:16:03 volumio go-librespot[15742]: time="2025-10-24T14:16:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:03 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:03 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:06 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:06 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 206. Oct 24 14:16:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:06 volumio go-librespot[15752]: go-librespot daemon starting... Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="app state loaded" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=info msg="zeroconf server listening on port 42811" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="obtained new client token: AAC2KZxUPTyC6fhnGe9wIrBOGMwDRdMpyr0mRg56ZlRQ8r2KkyLNP2UqvXYTj2qoVYadnHTnh7hIORCAVNuYFnUwliDqt8vDx0hVGsP77P03hIDBP9t7COF067Bop2MHj1PQRKk9IOLMi7FJi0YxKSa74DxEx5LOvTLwieww9miS17tEWMYGGNJ4XVePXhHKIAZD85K5dwmHsubNV76/2vYDmdWDj5MnRvS8zQqDpJjcoCf/iPVNC1E=" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=debug msg="completed challenge" Oct 24 14:16:06 volumio go-librespot[15753]: time="2025-10-24T14:16:06+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:09 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:09 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 207. Oct 24 14:16:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:10 volumio go-librespot[15774]: go-librespot daemon starting... Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="app state loaded" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=info msg="zeroconf server listening on port 44935" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="obtained new client token: AAD1d0txZh1pwCt9Rmy/SdQA6/OVqTAD96GsJCqODUsNLR8nJ4n76yNAHj8PmrtyNwfO9w2OowTzLzbg4a1fUJQujG3YzeLkI8GDMWaPHvcQ8Xn7LJw0L+vIdE1MAra121LaHSZ1M22gwUmVqiXGBf5m3jWoH2w8MiH7znHNkn6UVcLApDiIy170yrKEciGpQg5jaNbqtDzWZTO65Il3QApUmtlM77Zr3tx/E8FpEPDIrFk8NBAIfTQ=" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=debug msg="completed challenge" Oct 24 14:16:10 volumio go-librespot[15775]: time="2025-10-24T14:16:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:12 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:12 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 208. Oct 24 14:16:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:13 volumio go-librespot[15782]: go-librespot daemon starting... Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="app state loaded" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=info msg="zeroconf server listening on port 38825" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="obtained new client token: AABe+gNhYmWuUpYfwI6NBjBb5h2m9VJsQku7dC/3rlgeLPLHtYVQDoe744p4mTf5q4AntqoX3wTuRkdeF4YKU+sOtuxuaPgBUM9BgqiA7It09fZJC7ZtA1ELpNGeM5sZ+soqsTiX+BN3rrVWv3I56In4Awnu+37wjirXsy5MUyxkxEs+Yc090ZVTGqdk1K8+4ZMvl35RaWRX4wiGQr/UUwVyWuyIJ02WxLPjB3sqLViGc9yinLzxYJw=" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=debug msg="completed challenge" Oct 24 14:16:13 volumio go-librespot[15783]: time="2025-10-24T14:16:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:15 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:15 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 209. Oct 24 14:16:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:17 volumio go-librespot[15805]: go-librespot daemon starting... Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="app state loaded" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=info msg="zeroconf server listening on port 33299" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="obtained new client token: AAAi1HXcb0V1XkC/j9AZXBTUsXN2newdW/MFAEbljHrNrNCIS3dTSgfOc8yG9QKm8mFMxhiQ95N8Nk3fs1p9xTMsuc4mK+HIvFdyIgCYtREmm595ziRpD2ML4/jp4pRmcFkZNmJ7ltNFg2etXJ8FhaA3X4ttR7ISBYYInxEAIYgTTgEjutDwz4zSWUt5JTsnGcfpJGTtRfVi+Hnfm6XdQUOuseRSN0NIihTTSqYvFRS+Vaijh3plOWs=" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=debug msg="completed challenge" Oct 24 14:16:17 volumio go-librespot[15806]: time="2025-10-24T14:16:17+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:18 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:18 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 210. Oct 24 14:16:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:20 volumio go-librespot[15813]: go-librespot daemon starting... Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="app state loaded" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=info msg="zeroconf server listening on port 45401" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="obtained new client token: AABYLjEnNiVebOkuupvm1sUUlfzO2RmO6qIc6sP2n7Ftw9G/JIp845LgSJvafGRkycZipaIRglNyyL+u0qyS7v43tjJT2hAeRuXM/2OC5ywZwQf51BngiHYEUay+PEXnUUXxwSl0ax3XVfhM2UzgegrChvsXZCf+4xm9HmmrMvVs1pF0Tv/NFx02l0ALEs2HpeZB/GLv7+O/S6kSHIA1Bwn618sOkMrW0M1tz6T6y9v0yo6RTfvE1nU=" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=debug msg="completed challenge" Oct 24 14:16:20 volumio go-librespot[15814]: time="2025-10-24T14:16:20+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:21 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:21 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 211. Oct 24 14:16:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:24 volumio go-librespot[15824]: go-librespot daemon starting... Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="app state loaded" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=info msg="zeroconf server listening on port 39539" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="obtained new client token: AADiuL6K5vMgCzSxB9j5klUnMaBLqPliq/AP3vbSMexT8r3b4OSNh14ydZ1692pZn09nwps3FtUSviPkinZJ/6E+1MjE9WwW36+xm7ziml7sGf4vpO3RPTPlE7j08WBs+swhDPNO/DxR5ardJE3AJkffiVxuMADMwZqHidRcZ6JSxVh+o9S8i8qpzOkkOJRWZq2C8n3ORxxAMaJJc0OdxujdHy1zsu/GWBq26z4sJcVG0lf2DIIXlRc=" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=debug msg="completed challenge" Oct 24 14:16:24 volumio go-librespot[15825]: time="2025-10-24T14:16:24+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:24 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:24 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:27 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:27 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 212. Oct 24 14:16:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:27 volumio go-librespot[15846]: go-librespot daemon starting... Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="app state loaded" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=info msg="zeroconf server listening on port 41655" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="obtained new client token: AACGC4FM/FQSJ2FaLKzEQ88M82aGnfCl+hlBsyIzvk5bxKDylzjxE+HeeW5nAENIjj53rV3bkhdoIDy1mVUd/18P4hp1g5LAJNbfqDZCfq07uTT6qFyZSaFhF9dwOZLPyJEFmdOakWg4XmjcrBdOp8HbGbqUqmz8pZhK+odpNaq3bClEXTKt3TxeqROsV14IgCx36KSmDQvAJiakuCSh+0pfgdPZdjDCp/WTf2F0vCDzOuNBJ+5k0NY=" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=debug msg="completed challenge" Oct 24 14:16:27 volumio go-librespot[15847]: time="2025-10-24T14:16:27+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:30 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:30 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 213. Oct 24 14:16:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:31 volumio go-librespot[15854]: go-librespot daemon starting... Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="app state loaded" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=info msg="zeroconf server listening on port 34975" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="obtained new client token: AABmra0lKHpCD9oLSFjkeVXhPg01+FT+drKgUznLMGbDBWCohFduT9P6gpMyMJOp5rJdSkr8h5H05209rG1YR424/+YMM9APKKHuQ3U7GQ3HFtj95hLfYdlai3QVT4M4FJ0CWqfKBXNwlUcoCfhZRs2CCln+CxJ0FUptC89M+huPIjzt+QtX3wbzqui7xikfJcgRRQUd/AxB40Dd3nEo0aDeT3V6uJFCdnFxlVbODAOWj3fXUe35nLw=" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=debug msg="completed challenge" Oct 24 14:16:31 volumio go-librespot[15855]: time="2025-10-24T14:16:31+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:33 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:33 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 214. Oct 24 14:16:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:34 volumio go-librespot[15863]: go-librespot daemon starting... Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="app state loaded" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=info msg="zeroconf server listening on port 40335" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="obtained new client token: AACo9SCr/dhHMeofOF+v/yT9ES1DHFw0Zmwq6M4BjhgyEcbBfbHQgb7WOz0DvPjfAjhyJLS4lRVmUq2CR3eOyLt7i4hbL4E75hHmg6Z/TRWQJBCm9b4e9TUMGK8ppG+YwgyvrNs+oqF6iH+tiY6BzWdah4G+tIuYhd3uV0/RkZEXvm0fwLNTqivzRKqRusmy/mnVasSxoUmd0+eDwJQ2JFYZtw+FYs0ySFpvalJ6tYVY2fcTmCBNqsU=" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=debug msg="completed challenge" Oct 24 14:16:34 volumio go-librespot[15864]: time="2025-10-24T14:16:34+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:36 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:36 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 215. Oct 24 14:16:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:38 volumio go-librespot[15885]: go-librespot daemon starting... Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="app state loaded" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=info msg="zeroconf server listening on port 42033" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="obtained new client token: AADVkzwW4RyOTwHEGxDvw8yJOT0B4RyjJpuMRuYEpnzol+MAZ/xYleS3gOzhsUQS9dkgfKeedM+51XbmN2KnaGh/mV/UEXwMfKz1uNR+gXGG27CgsvpVLCzp5qCBgevyZdOurd73FC2h7PXO21+2nSruuJYZOI5KW/XI0dAF60nCNW0BE+2Dpvgp3FKsVLbqO6xjyqgsSG4ZTuz1R8A/b8DVqcr5tX12oTmxZJhCjDXw3L4GXAjqPho=" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=debug msg="completed challenge" Oct 24 14:16:38 volumio go-librespot[15886]: time="2025-10-24T14:16:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:39 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:39 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 216. Oct 24 14:16:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:41 volumio go-librespot[15894]: go-librespot daemon starting... Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="app state loaded" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=info msg="zeroconf server listening on port 45139" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="obtained new client token: AACrDgxHXB1etAusQS/limO0fq9op2+fGQwnc0UOdk06bvK4SYZW6Nw2bK7VkuG95msJ8YmdmOqni0D1ch8ITqv80VkUetIDI4EMnwhPQEvdZHZS9ffyHcuupNjREx8Ry4Bi5Q0qj+FlSPGY58kZ5WiHo7lY9JdVSwrneZtAloin8DjsDDklcxW7oBfi0b+WUBN/2MHMazroHOhZf3bvf7hgBty/aeeoVhRMxIiNcDsxILWNNtAn9Ac=" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=debug msg="completed challenge" Oct 24 14:16:41 volumio go-librespot[15895]: time="2025-10-24T14:16:41+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:42 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:42 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 217. Oct 24 14:16:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:45 volumio go-librespot[15905]: go-librespot daemon starting... Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="app state loaded" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=info msg="zeroconf server listening on port 45625" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="obtained new client token: AAAxVybrZppeZkq6/pHMf6YQ2VJWIp1bZrwGwcZLn76ne2PdR0kcxtHoZhQGRL8eSS4OJ6drPHzRHcnx18gedrQCfUMALfpVpQOuK0DkYd6NxnzvpsSuonOsfioH4RMOBa3JX0QJBgysGe8MHvx4m2DtVwUn22wvbKnc+O7O/9fil15MybejBOheLTvlh2igfXPq60G2HJpSdYg5UF1uwWB0U+F4Uo/oHOTVQv2D8mTy8ZuuTqFsRaA=" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=debug msg="completed challenge" Oct 24 14:16:45 volumio go-librespot[15906]: time="2025-10-24T14:16:45+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:45 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:45 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:48 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:48 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 218. Oct 24 14:16:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:48 volumio go-librespot[15927]: go-librespot daemon starting... Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="app state loaded" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=info msg="zeroconf server listening on port 32927" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="obtained new client token: AAC0T7YHz9w94adfqReHfOpCOLuraJKbftEhJqG8F3imbEcjSw+6jTFlHWmTyJRx+Wg82dn0fD2td3obzHLwclyaUS0D1LQJmIUgLdJFu18tZ+EfbY+atSyKj6mIs7eXBIuTuJ8oeAY+3sNRfX6fqQ9ARDJMKhwuFmouZe37geehLQ2Ga80BN0jRFmd1ZwkHJXHcPvQnYTGCN0sJqx+h5pDd/P5ayBa+7+3RMoYyvL70T3CaiZlBq9g=" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=debug msg="completed challenge" Oct 24 14:16:48 volumio go-librespot[15928]: time="2025-10-24T14:16:48+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:51 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:51 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 219. Oct 24 14:16:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:52 volumio go-librespot[15937]: go-librespot daemon starting... Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="app state loaded" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=info msg="zeroconf server listening on port 33321" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="obtained new client token: AAA6bG6cH5EdEhpf3pNQRfIpE5tq0qSUSFf8HucrpatCvA5j6Aoi8jDNXvUMio8Yc1sAtSmEg2qCJ+zpTsvanAXHM6JFLs5xxFOU145WxVn3pcxYptMXNbDDiPDewO3+bu+zl8pzOwKzsJhG7aiWneKMp8QRym2qzuhVzDKRIm+24W1sPwRA/5dztqE1OValJMex22u7XlVyv2w16O0CrfsRvm4UYG3Js9N91i6TdazY+FwH1JRHSBY=" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=debug msg="completed challenge" Oct 24 14:16:52 volumio go-librespot[15938]: time="2025-10-24T14:16:52+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:54 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:54 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 220. Oct 24 14:16:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:55 volumio go-librespot[15945]: go-librespot daemon starting... Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="app state loaded" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=info msg="zeroconf server listening on port 40375" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="obtained new client token: AADXzVmBnWUNdS57Ayo/bZgZwtcWVO1aafNvbwwv+7p/n7N3WdhK+PFN0hIsL8V4mcEHKd+K86SdOJzq7zm05OuqmbeHlG5Y+6VpBiX5kQlTAEOgbI33nhUIIkpCeiMh67zDEFCR38TQpyo+/+eAFCxr1F2pXo7bNHSViK3bigUNhXCJTiXjDWG7+XbmEldmQfRe7cdC5/+BKKKYECcUL2/kiWgsylM/ROQbeSjHUE2/Dtlktdz7Fu8=" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=debug msg="completed challenge" Oct 24 14:16:55 volumio go-librespot[15946]: time="2025-10-24T14:16:55+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:16:57 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:16:57 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:16:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 221. Oct 24 14:16:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:16:59 volumio go-librespot[15967]: go-librespot daemon starting... Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="app state loaded" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=info msg="zeroconf server listening on port 44251" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="obtained new client token: AACtZJcrixvCvzZEv48XXGGUs/k5MCoVPDn475LJV72jP+8R/xPd7fvslo5rKIJU9WzHQu6ei536S3/v53NgI825MGajHCpVSDZBn5xyYh5RcDyiqJPFiZjZWxZM+YLxtaV/Ho/+Q9zr8Nc7llAU+I17EuIi1sP9vNTrrZ/AQP7fyFirXPTz7l/w5JEbCRVnUfK/IzuiOjUIeYEwAVeG5t68IOcryiHq4FiZoMHhPS5qC829kjzIjxI=" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="completed keyexchange" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=debug msg="completed challenge" Oct 24 14:16:59 volumio go-librespot[15968]: time="2025-10-24T14:16:59+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:16:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:16:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:00 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:00 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 222. Oct 24 14:17:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:02 volumio go-librespot[15975]: go-librespot daemon starting... Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="app state loaded" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=info msg="zeroconf server listening on port 46851" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="obtained new client token: AADTvxBPKb5OT+63cfDacyGq7uv4KWKU5Qhm/+e+78pFoE84ujQV3//zgfgRwgQOxbcVAqdpgWipldhmvHWGqN3J3JkuFmKhrP0wNkw7dsEQPrGLGV+YMZuDcCrhi945E/EM0h+oHDersIQmay1cuKHYEop+i8raD4MkwmGKr5vXm0f/31FWMpYN0LrKUxSsa4YtOlkx3CzPoT+WqqUc1D3GZfq2gy9Qh8RVCBiuYjax+PvQ+h8XmWI=" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=debug msg="completed challenge" Oct 24 14:17:02 volumio go-librespot[15976]: time="2025-10-24T14:17:02+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:03 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:03 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 223. Oct 24 14:17:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:06 volumio go-librespot[15986]: go-librespot daemon starting... Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="app state loaded" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=info msg="zeroconf server listening on port 41085" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="obtained new client token: AABTei7nSTkieOPrI2w1fd97KfaV5BciAzpYChm6i4TnVfBPJ//kN6bH9H9G1OH4cd9ngkJlH3omQDsbSPed6PcMUQpw/CAZdhbMkyGTn4ItZYCmQeKSetvJ3Etx0/FmcGu48zg/tKsmArB5j9WkOpsmr0B0UfLrwq18076op2CxzUkfxqxLPNQ3+OkvAjjA6XUUhtlKNs+wo8sB9Zfto37f2YmbPA2/sFxpevd6N7UOHM2ZXpJRUxc=" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=debug msg="completed challenge" Oct 24 14:17:06 volumio go-librespot[15987]: time="2025-10-24T14:17:06+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:06 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:06 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:09 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 224. Oct 24 14:17:09 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:09 volumio go-librespot[16008]: go-librespot daemon starting... Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="app state loaded" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=info msg="zeroconf server listening on port 40919" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="obtained new client token: AAC9ansb8dCyB6Md86t5AkcFWlNeHwG2reBuc43FXiZx9j1qWbY1+WmGEGnjROdMCTh1WWY1ug7w5nqUYLgbjztfCBLGMitsDg4W2dns26sGKHcyB+439mQ8WF6dGu1h/Kf5K3V2rI+Oukwe1WHjwSbA18mbLXxGczAju4BWhoODLeYNqvhH4Q/lEbh2FVBJ9Twi1KJN7ZDoa+tbbvfAb0m0vkY1CZdDBnj66310c5GHpdyqejo42zU=" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=debug msg="completed challenge" Oct 24 14:17:09 volumio go-librespot[16009]: time="2025-10-24T14:17:09+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:12 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:12 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 225. Oct 24 14:17:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:12 volumio go-librespot[16017]: go-librespot daemon starting... Oct 24 14:17:12 volumio go-librespot[16018]: time="2025-10-24T14:17:12+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:12 volumio go-librespot[16018]: time="2025-10-24T14:17:12+01:00" level=debug msg="app state loaded" Oct 24 14:17:12 volumio go-librespot[16018]: time="2025-10-24T14:17:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=info msg="zeroconf server listening on port 34445" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="obtained new client token: AADEUUVPn3+FKJC7sYlotlBdAI/YfXcxSAsQlBy7TyvfLT7+Z8HTRLFx8BMnS9z68Q54+maapuTOA5HekFjQMLubRd7SxaifsHzqkMSZIM0mLnxQslzL1Ggu/WjYZAKRLJzzNYd1toYX6GQ2dWwAmfPj4h7aJaSB92d2zvxPxzUfdpb+zhVusD8Q6GEkXfeFXOhuKgcXxuWQzBWgnpULoZMOkO0swVWKBPyrKc8Pqs3+EoVNMw/j" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=debug msg="completed challenge" Oct 24 14:17:13 volumio go-librespot[16018]: time="2025-10-24T14:17:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:15 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:15 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 226. Oct 24 14:17:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:16 volumio go-librespot[16025]: go-librespot daemon starting... Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="app state loaded" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=info msg="zeroconf server listening on port 44899" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="obtained new client token: AACT7Y7nVimlNbaEXJHTXDeqq7Gzec2rYbU7HwxwQ5c+WTVFWt+riTGRZ/4bLdNLGvDhn8BuBcHLKGQUEmu1VHjEs0YVOl2dgRIjSh+LFQN6O4cJ+jxITJiCi4gtJf3Q7xUongDfNom+B/iSKV8ittT0QZwZ8VTyCQz6yN6dk3jQFEsQkCivNfg3Au3/bQBR5DfR/2e12ePn5BASE3MYySrPO5v/iRlR61XKvtfCEi57pF7A0Q7JLRM=" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=debug msg="completed challenge" Oct 24 14:17:16 volumio go-librespot[16026]: time="2025-10-24T14:17:16+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:18 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:18 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 227. Oct 24 14:17:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:19 volumio go-librespot[16047]: go-librespot daemon starting... Oct 24 14:17:19 volumio go-librespot[16048]: time="2025-10-24T14:17:19+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:19 volumio go-librespot[16048]: time="2025-10-24T14:17:19+01:00" level=debug msg="app state loaded" Oct 24 14:17:19 volumio go-librespot[16048]: time="2025-10-24T14:17:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=info msg="zeroconf server listening on port 40253" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="obtained new client token: AACTI8hMeHFi39O9L6YJrCs7teBBAGGD8vBywiGGWIKdR7ee/T1gcx+UUvFrZ7pVhw552poWc+MA3pF7/jt4Ht7idyB97hFpQEV1hbhTDY+xVxLdgjRk6+4A2q083y5GuvruVjjxQ4hdjwC98b7MuuBTY+gf6Vqm2AApTWHGcqNPLbtblbV9Qs/FttPcV6xumra4oEd86A5HvUW6NDIGGb9uyXu/D1jpvZ7OyEPjzSIZod5FpU7E" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=debug msg="completed challenge" Oct 24 14:17:20 volumio go-librespot[16048]: time="2025-10-24T14:17:20+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:21 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:21 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 228. Oct 24 14:17:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:23 volumio go-librespot[16055]: go-librespot daemon starting... Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="app state loaded" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=info msg="zeroconf server listening on port 33443" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="obtained new client token: AACtl23TcnsOvrq00dJsRcNvZcPkNPfVFrthxR9Hya9KPXE2kbFjxRZRCSdTVbLHYKd8SEJRcSykAX7fvhMcn+HBNQc2+YYeZLbm2uaYK4+nlBUGMZBkMW34hmXtRW3J2YuHoIK24nZTPXpVQ7xmUOOy+lnspR8//gBmvWrYVBJYqhCAHrtJ8vbKRWVePyAWq6Jgh4OM0mscAT2ZaeUpV25izLjArrV/xY7Fb5aLLX4Gqu85bK5taN0=" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=debug msg="completed challenge" Oct 24 14:17:23 volumio go-librespot[16056]: time="2025-10-24T14:17:23+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:24 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:24 volumio volumio[15194]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 24 14:17:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 229. Oct 24 14:17:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 24 14:17:26 volumio go-librespot[16066]: go-librespot daemon starting... Oct 24 14:17:26 volumio go-librespot[16075]: time="2025-10-24T14:17:26+01:00" level=info msg="running go-librespot 0.4.0" Oct 24 14:17:26 volumio go-librespot[16075]: time="2025-10-24T14:17:26+01:00" level=debug msg="app state loaded" Oct 24 14:17:26 volumio go-librespot[16075]: time="2025-10-24T14:17:26+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 24 14:17:27 volumio go-librespot[16075]: time="2025-10-24T14:17:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 24 14:17:27 volumio go-librespot[16075]: time="2025-10-24T14:17:27+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 24 14:17:27 volumio go-librespot[16075]: time="2025-10-24T14:17:27+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 24 14:17:27 volumio go-librespot[16075]: time="2025-10-24T14:17:27+01:00" level=info msg="zeroconf server listening on port 41591" Oct 24 14:17:27 volumio volumio[15194]: info: Initializing connection to go-librespot Websocket Oct 24 14:17:27 volumio go-librespot[16075]: time="2025-10-24T14:17:27+01:00" level=debug msg="new websocket client" Oct 24 14:17:27 volumio volumio[15194]: info: Connection to go-librespot Websocket established Oct 24 14:17:30 volumio volumio[15194]: info: Getting Spotify volume Oct 24 14:17:30 volumio volumio[15194]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 24 14:17:30 volumio volumio[15194]: info: CoreCommandRouter::volumioGetState Oct 24 14:17:30 volumio volumio[15194]: info: CorePlayQueue::getTrack 0 Oct 24 14:17:30 volumio volumio[15194]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Oct 24 14:17:30 volumio volumio[15194]: SPOTIFY: SPOTIFY VOLUME undefined Oct 24 14:17:30 volumio volumio[15194]: SPOTIFY: VOLUMIO VOLUME 51 Oct 24 14:17:30 volumio volumio[15194]: info: Aligning Spotify Volume to Volumio Volume Oct 24 14:17:30 volumio volumio[15194]: info: CoreCommandRouter::volumioGetState Oct 24 14:17:30 volumio volumio[15194]: info: CorePlayQueue::getTrack 0 Oct 24 14:17:30 volumio volumio[15194]: info: Setting Spotify Volume from Volumio: 51 Oct 24 14:17:30 volumio go-librespot[16075]: time="2025-10-24T14:17:30+01:00" level=debug msg="obtained new client token: AAABZ8suLjh+T3TeSk9da8bDrSepcNTIqXeInGgORb99ObZj/I2x9JQjsW5k+h9LP8Ql94OGAPHUZR8LH3DYCXRKdd24ab1X/AfBh8JH5UXD+ly6XjMV6xu9yG541+tg59pyXa/7kutREocgrZJzyKuFIJVerUMnjCIwGvDNjgcnpE52GbXUFWrocW+IubelMsXcKujbsiypZp2w/ZSLY4UUAX3A2kymqK7BUE0uYJRN66xzPjtZk9g=" Oct 24 14:17:30 volumio go-librespot[16075]: time="2025-10-24T14:17:30+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 24 14:17:30 volumio go-librespot[16075]: time="2025-10-24T14:17:30+01:00" level=debug msg="completed keyexchange" Oct 24 14:17:30 volumio go-librespot[16075]: time="2025-10-24T14:17:30+01:00" level=debug msg="completed challenge" Oct 24 14:17:31 volumio go-librespot[16075]: time="2025-10-24T14:17:31+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 24 14:17:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 24 14:17:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 24 14:17:31 volumio volumio[15194]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 14:17:31 volumio volumio[15194]: Error: socket hang up Oct 24 14:17:31 volumio volumio[15194]: at connResetException (node:internal/errors:720:14) Oct 24 14:17:31 volumio volumio[15194]: at Socket.socketOnEnd (node:_http_client:519:23) Oct 24 14:17:31 volumio volumio[15194]: at Socket.emit (node:events:526:35) Oct 24 14:17:31 volumio volumio[15194]: at endReadableNT (node:internal/streams/readable:1376:12) Oct 24 14:17:31 volumio volumio[15194]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Oct 24 14:17:31 volumio volumio[15194]: code: 'ECONNRESET', Oct 24 14:17:31 volumio volumio[15194]: response: undefined Oct 24 14:17:31 volumio volumio[15194]: } Oct 24 14:17:31 volumio volumio[15194]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 14:17:31 volumio sudo[16102]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-24 14:16' Oct 24 14:17:31 volumio sudo[16102]: 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"