Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 12:37:00 volumio volumio[19164]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 03 12:37:00 volumio volumio[19164]: info: Completed starting MyVolumio Plugin Nov 03 12:37:00 volumio volumio[19164]: [Metrics] CommandRouter: 32s 69.87ms Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::Close All Modals sent Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::Close All Modals sent Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 12:37:00 volumio volumio-remote-updater[874]: Test mode disabled Nov 03 12:37:00 volumio volumio-remote-updater[874]: Alpha mode disabled Nov 03 12:37:00 volumio volumio-remote-updater[874]: Alpha legacy test mode disabled Nov 03 12:37:00 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 12:37:01 volumio volumio[19164]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 12:37:01 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 12:37:01 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:01 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:01 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 12:37:01 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 12:37:01 volumio volumio[19164]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 12:37:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 764. Nov 03 12:37:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:02 volumio go-librespot[19616]: go-librespot daemon starting... Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=debug msg="app state loaded" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" 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 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" 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 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=info msg="zeroconf server listening on port 43219" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=debug msg="obtained new client token: AAB1JHbbhJDCBjh3dDMDNGpmpIwPVcOMmG4vZbXbflERs+onz467iUPAcflwbHgpxd2b7ViCQmbX7H9yswoc68J3vCz/KY+maUg8wcc4DMZkvwXeD4S9GH7RMQ0q36CEverU06irDrFrEgOTBq18GKtOiO91Eqc5rZ7bj07wC9iFepQaHEdp3/jXwBc/6+qWz5CCCzOUjGPBvRs5ceV6ohHXg1CpZdVSmXOSZC8TE54zug7ci9QasCA=" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=debug msg="completed keyexchange" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37:02Z" level=debug msg="completed challenge" Nov 03 12:37:02 volumio go-librespot[19617]: time="2025-11-03T12:37: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 03 12:37:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:04 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:04 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 765. Nov 03 12:37:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:05 volumio go-librespot[19625]: go-librespot daemon starting... Nov 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" level=debug msg="app state loaded" Nov 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" 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 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" 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 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" 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 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" level=info msg="zeroconf server listening on port 46019" Nov 03 12:37:05 volumio go-librespot[19626]: time="2025-11-03T12:37:05Z" level=debug msg="obtained new client token: AAB8fDpY7h2DjlcUdQiPTHrW6J5ktmSq3RX6jq/nvfo3snd9PfKNWPBBceHFGGCJ5ZoPpEv/CnrkAN11cWiYWrSRLH9AQfBS3ajL19EHDs3Pv5lY8VD6DGG38K7KfIC/xKU+kkjyzW1NWfAJ8CZBP4K82AuddzhiywnS8++QV+SjDa/CiNJEegAr1cwQXI+3hcotuTKd2Mc0ZrW04BsfCMf3bzOGQu++HoKDKwn74CezLvqzCz8oYV0=" Nov 03 12:37:06 volumio go-librespot[19626]: time="2025-11-03T12:37:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:06 volumio go-librespot[19626]: time="2025-11-03T12:37:06Z" level=debug msg="completed keyexchange" Nov 03 12:37:06 volumio go-librespot[19626]: time="2025-11-03T12:37:06Z" level=debug msg="completed challenge" Nov 03 12:37:06 volumio go-librespot[19626]: time="2025-11-03T12:37: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 03 12:37:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:07 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:07 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:07 volumio volumio[19164]: info: BOOT COMPLETED Nov 03 12:37:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 766. Nov 03 12:37:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:09 volumio go-librespot[19647]: go-librespot daemon starting... Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=debug msg="app state loaded" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" 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 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" 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 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" 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 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=info msg="zeroconf server listening on port 38203" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=debug msg="obtained new client token: AAD20bBkJ5tNw2pUIhuuBGKfrDV+ltmT+01+NOGbAJ5dv1Yvfl0sGRa8RUHsLWUZZtA0fJ/tf2kQPB2y3hTucn3WWS49CrhECHrQML88uXxDHu0RT/BksjrrqdCW8UszHZVuKFKyZ5GRv/8Gm5c9WIFKrXQpxyDN8DjOblk3g+3WiZWCgQMSZU8C4CdPQCpIcggeKbZnKFKThhq1vxDEgUlD4bsHWAz9TrzLimEfgW2l/Mw1Vv1HeGk=" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=debug msg="completed keyexchange" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37:09Z" level=debug msg="completed challenge" Nov 03 12:37:09 volumio go-librespot[19648]: time="2025-11-03T12:37: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 03 12:37:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:10 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:10 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 767. Nov 03 12:37:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:12 volumio go-librespot[19656]: go-librespot daemon starting... Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=debug msg="app state loaded" Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" 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 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" 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 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" 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 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=info msg="zeroconf server listening on port 42395" Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=debug msg="obtained new client token: AADnNfxOcnVe5fqnH35plm+bZim1xsGkxuGKyectWlJTRZ+dIjhQ+a2GX8LE0cQ8W28br0aSUTe5efom6LZjzbwsDtZl6AUq/h5vsbpRulyupYOqh9+GyDwxpkBCE26Hyoz92jJcyA8NJ80WnxAI5Nt50J+LFnAjzHs+XBxmgkRneYp7R96leTd5rRNMjwommnBRWWV7M3gIpPomOyDEjhUoUBaew1dNL5K6E4rpi1l/dMBOP2iOx0U=" Nov 03 12:37:12 volumio go-librespot[19657]: time="2025-11-03T12:37:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:13 volumio go-librespot[19657]: time="2025-11-03T12:37:13Z" level=debug msg="completed keyexchange" Nov 03 12:37:13 volumio go-librespot[19657]: time="2025-11-03T12:37:13Z" level=debug msg="completed challenge" Nov 03 12:37:13 volumio go-librespot[19657]: time="2025-11-03T12:37: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 03 12:37:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:13 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:13 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:16 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:16 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 768. Nov 03 12:37:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:16 volumio go-librespot[19667]: go-librespot daemon starting... Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=debug msg="app state loaded" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" 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 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" 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 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=info msg="zeroconf server listening on port 36697" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=debug msg="obtained new client token: AAA11Sdw0aksV3u5z7chCBiotA+dyg8Hw4lfwjN6LY+HuGtRGS38ZkolkxmLdSpIU5o/8vYep3+B68pf0qyYGDiC9+Qacpy3nFyU6qTVSkmL+UGmtJivcKuz2GDnMR+9q2EJX0ZOGTHlcPz5uwbYXL/oW2tn9QBvvxBYimRpQTYxXi8nbL25PKaogThs9WaDOiIBzeJAEsyKROFxH0XJEh4C8OnoqZcFR/F2FTbJeQyVp2YehWoz65s=" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=debug msg="completed keyexchange" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37:16Z" level=debug msg="completed challenge" Nov 03 12:37:16 volumio go-librespot[19668]: time="2025-11-03T12:37: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 03 12:37:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:19 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:19 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 769. Nov 03 12:37:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:19 volumio go-librespot[19689]: go-librespot daemon starting... Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=debug msg="app state loaded" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" 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 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" 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 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" 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 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=info msg="zeroconf server listening on port 35239" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=debug msg="obtained new client token: AACM0SR3PrA0EeYqqZi3N+Jb51kztXx2yn2ZwlK38TKyt3cd7Ammx98uMMNPL7mygSIl3+wx07ZvthS1Z5Rq52UMOUNhd8OD0sqwqI98BieT90eoyeP9Ow3V6pG/NggDm7S5jjqBBhD7z220d/FVmL4fkvX1W9FV7puLwGByJrfJaDLcEv4/3iCBrdAMayzjln9DZ5C8GCDSa55ia/70d0CxbdfBdqpbHMo1Nq68ER3wRb9ttr5pJzs=" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=debug msg="completed keyexchange" Nov 03 12:37:19 volumio go-librespot[19690]: time="2025-11-03T12:37:19Z" level=debug msg="completed challenge" Nov 03 12:37:20 volumio go-librespot[19690]: time="2025-11-03T12:37: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 03 12:37:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:22 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:22 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 770. Nov 03 12:37:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:23 volumio go-librespot[19698]: go-librespot daemon starting... Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=debug msg="app state loaded" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" 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 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" 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 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" 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 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=info msg="zeroconf server listening on port 42209" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=debug msg="obtained new client token: AABcydSccsYA1rYgA3pJEuHIWM2o8HTYZEJXjfNaxRLNe7dukNgrcRof5k50gZyRqOXgRvIWl31ZaMkdrSI0EIcXbH5DCrGGIbrd4KxYmDNsUl52ujkEgfC/KcQ6lYMW48IAX0ltT04yVxzS2NVpsnEp7rVjVIiASV8iuJvtx4FVtCdys59GE0rlA5+KqggxdMcq26TKrSqJGVhN2fJTFUEwC25m4yqdvMuB0EIEqyYFqi1zJS+KXCc=" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=debug msg="completed keyexchange" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37:23Z" level=debug msg="completed challenge" Nov 03 12:37:23 volumio go-librespot[19699]: time="2025-11-03T12:37: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 03 12:37:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:25 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:25 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 771. Nov 03 12:37:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:26 volumio go-librespot[19707]: go-librespot daemon starting... Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=debug msg="app state loaded" Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" 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 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" 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 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" 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 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=info msg="zeroconf server listening on port 35473" Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=debug msg="obtained new client token: AADyUQ1fkgSZtaMoPtt2rpFXz79KHo1wFX9rhwgFTBn3y9FMSQlUu03GX/WvVCaIiFvLiE//ftParhIQdVY9HY/XU43Px2BRYDZ01MIcXVZaSeCsx4fNZLN4X5yybpImUfIdBkqZAYSe0yJVtldbPzJa4jbR+Ow2mikkjK3ZMzkVc90sjoI1hmXWq1U/I9sLtOMvZIUtYGJGhwdo/pAE39jiOkfHlgNMMdv01fud5+qEn4MF9z2wCck=" Nov 03 12:37:26 volumio go-librespot[19708]: time="2025-11-03T12:37:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:27 volumio go-librespot[19708]: time="2025-11-03T12:37:27Z" level=debug msg="completed keyexchange" Nov 03 12:37:27 volumio go-librespot[19708]: time="2025-11-03T12:37:27Z" level=debug msg="completed challenge" Nov 03 12:37:27 volumio go-librespot[19708]: time="2025-11-03T12:37: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 03 12:37:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:28 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:28 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 772. Nov 03 12:37:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:30 volumio go-librespot[19729]: go-librespot daemon starting... Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=debug msg="app state loaded" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37: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 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37: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 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37: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 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=info msg="zeroconf server listening on port 37833" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=debug msg="obtained new client token: AABHlPfB2p/ymP0wzDQwZkfWDD0U3fXF8ooKdMiMBV6JA9DGEsYqC0Hoxkz3APpRKy9mbZcK78E2vk1HZxZQogRwc/nby1cn4zXB+0WmjPiIqBT1TpkJPY+5KY+bhnlY2C0tadFb6UoD1Gv3AhuRLuSMn52xnIJoe0s+XO2ix3getCZogBafCymA/+EXFq4YrOf/HI/ETnrtti+e+meN+NjupXPYP3f+O08Fb+ll3khJx6NzI6s9+lY=" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=debug msg="completed keyexchange" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37:30Z" level=debug msg="completed challenge" Nov 03 12:37:30 volumio go-librespot[19730]: time="2025-11-03T12:37: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 03 12:37:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:31 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:31 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 773. Nov 03 12:37:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:33 volumio go-librespot[19737]: go-librespot daemon starting... Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=debug msg="app state loaded" Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" 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 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" 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 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" 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 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=info msg="zeroconf server listening on port 44363" Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=debug msg="obtained new client token: AAAQc0wZ5rNEi556FflNHdzhQJTsOfMGwgMtNdfX6ID6Pd57OVcj1pyS+mPo+PiTfl7xoZT2y8/c1tSe+Voo/+EHUrTY3rb85ki7VwLlV0WyzSaHy1I9NiaPE8yUCkNOUTkWJbvV91wGWfVHWsHkIxVV9LyG0MKKt+hW7S6YbxC8e1xoqGr9AdRocO3fGK+qlJF8xypjjietl+EIG5XNQwazqNAxjVxqTTixgaPbue/eOpmaAdI4+mI=" Nov 03 12:37:33 volumio go-librespot[19738]: time="2025-11-03T12:37:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:34 volumio go-librespot[19738]: time="2025-11-03T12:37:34Z" level=debug msg="completed keyexchange" Nov 03 12:37:34 volumio go-librespot[19738]: time="2025-11-03T12:37:34Z" level=debug msg="completed challenge" Nov 03 12:37:34 volumio go-librespot[19738]: time="2025-11-03T12:37: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 03 12:37:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:34 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:34 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:37 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:37 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 774. Nov 03 12:37:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:37 volumio go-librespot[19748]: go-librespot daemon starting... Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=debug msg="app state loaded" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" 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 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" 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 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=info msg="zeroconf server listening on port 43139" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=debug msg="obtained new client token: AADakQO83E2gEU36nKCcWpOSdDN8218mlKQb8DY7kqT4K3suJW2IYs9HzijMBC1Qqd07Sd4qtGEdkBLpZlXtgYVYK/BsxJJk6DZb2jboaJgbVsQM2xkEOklC7D2ZQo5AgTswyKiHfJqQaud9KnOYZCi4Y+X8Oonyfvq1T0Mof+VkrxZL9FHR2h2UT/9yJPUTKg26zolBvB+UWzKzbyN2Bp3LfqiEo9kjQQtrzRZG7AdVWdrKPUEFgZg=" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=debug msg="completed keyexchange" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37:37Z" level=debug msg="completed challenge" Nov 03 12:37:37 volumio go-librespot[19749]: time="2025-11-03T12:37: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 03 12:37:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:40 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:40 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 775. Nov 03 12:37:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:40 volumio go-librespot[19770]: go-librespot daemon starting... Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=debug msg="app state loaded" Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" 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 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" 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 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" 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 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=info msg="zeroconf server listening on port 46499" Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=debug msg="obtained new client token: AAB8AbfEMmkH7KfTSwwLmOEVCbsiG2n9+lqq5ccU1+6U+jUDARnsEti0tzPyw5bwyoy+ZKo80HGHIBSuYfWmeIa5O8O40/YObs5U5+KFnwNAfzb3gjDXmRxf0jnPgch6n2SCUEMWe3knc0HIZ8PBo1RItNuXQaJEUrVrnr+LijGQy8jnmHCd1fASJogt+81LXg1257NpXUbbDTGzrK5+O5EHLhgZgJZJgog3IoDalPNKeXFd+rfxRRk=" Nov 03 12:37:40 volumio go-librespot[19771]: time="2025-11-03T12:37:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:41 volumio go-librespot[19771]: time="2025-11-03T12:37:41Z" level=debug msg="completed keyexchange" Nov 03 12:37:41 volumio go-librespot[19771]: time="2025-11-03T12:37:41Z" level=debug msg="completed challenge" Nov 03 12:37:41 volumio go-librespot[19771]: time="2025-11-03T12:37: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 03 12:37:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:43 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:43 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 776. Nov 03 12:37:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:44 volumio go-librespot[19778]: go-librespot daemon starting... Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=debug msg="app state loaded" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" 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 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" 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 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" 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 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=info msg="zeroconf server listening on port 43391" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=debug msg="obtained new client token: AADu9cDfnqLuApN9WD3yGUDXRO4tqN/oLwdALZ14nuDZFPXPeyQ7oqM9yASuPr6gUNYuW3ZLnsA1X1DFJiX7FWzpronHyrcAqxOb47021PQYjSZ0OTD9za8ObzrIJlenmOJFiWyligXoa4VJ8VdNqKvuHBDHiKpjH0nkKAlRpXaQSLRu6vdFQ/2SgZO9xxqQ8fEeXihJlT2KbRoo9DJX0sRxpJzZfgpT3ZKNbQXaEkJ0hEczyoRZ/Ws=" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=debug msg="completed keyexchange" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=debug msg="completed challenge" Nov 03 12:37:44 volumio go-librespot[19779]: time="2025-11-03T12:37:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:37:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:46 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:46 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 777. Nov 03 12:37:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:47 volumio go-librespot[19786]: go-librespot daemon starting... Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=debug msg="app state loaded" Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" 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 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" 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 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" 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 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=info msg="zeroconf server listening on port 40479" Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=debug msg="obtained new client token: AACH4cuBynWAk2qqlxAayGpQ2xuPRduqwRShZJMZdvjBocOC/fohXsq2eB6M82BYLc08E7AuqRy5bMfGMPqRgSK+VMi72zlqa4MEqC6l+2mYb2T0XRyVLGPmSomVMuq6G/D3aOxF6W8v71IRS+utQfaRp+dUcHPPhMg9GZznCIyeZKZ78bfGq/cEXlVB4GXcSrfyK03bDViEZlome+zOuvEOOjFFqONtSlvwCvpAxpN7DIixQjN//vE=" Nov 03 12:37:47 volumio go-librespot[19787]: time="2025-11-03T12:37:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:48 volumio go-librespot[19787]: time="2025-11-03T12:37:48Z" level=debug msg="completed keyexchange" Nov 03 12:37:48 volumio go-librespot[19787]: time="2025-11-03T12:37:48Z" level=debug msg="completed challenge" Nov 03 12:37:48 volumio go-librespot[19787]: time="2025-11-03T12:37: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 03 12:37:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:49 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:49 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 778. Nov 03 12:37:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:51 volumio go-librespot[19809]: go-librespot daemon starting... Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=debug msg="app state loaded" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" 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 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" 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 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" 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 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=info msg="zeroconf server listening on port 46593" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=debug msg="obtained new client token: AAA56N1c4UlkAdMcb/sOTTW/LR2AKtOHtvh9D8yzMUB1/z1CeMGjZWIhNgHpKY4+jn+ZWapdGsD7/uPrHQZT+75GoV8mXQe5exx+WqJ49a1iCkForjvZkX3+wJIa4WB8Q/TGP7TeDuiLiW6nNd57Y/8jc0HmdmyTsGotJp4VJ//oqq4uZSfdaAUfCJ/lxp21pA1N8QES9fjPuokKW3/3Mbl8zSxlr6JhdHPK80w6yDB4q6ilIdXKu0Q=" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=debug msg="completed keyexchange" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=debug msg="completed challenge" Nov 03 12:37:51 volumio go-librespot[19810]: time="2025-11-03T12:37:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:37:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:52 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:52 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 779. Nov 03 12:37:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:54 volumio go-librespot[19820]: go-librespot daemon starting... Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=debug msg="app state loaded" Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" 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 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" 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 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" 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 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=info msg="zeroconf server listening on port 43413" Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=debug msg="obtained new client token: AABL7u0Sr4Xwe9mpUJkdoLOrRSc/00h0CMSzEDMcuILg9ZpGZYtkGVH9RGDTUDtP1JW/bHQvpUjRU0O06iI4AEsW6iR+uD3KXZShIF00Zo6aFqlm2hRIwodt1ofswBv6EdK5loYVR1rV48l/y049sEafXcXRBuZS2eY1T6pBE+QkOyorqmcNyJF++8PfpR5zp2JhDQ8iAoY3J4rXketKzVQww1Y3n0fu1cliDkvYdROcLdMrkZgNXyc=" Nov 03 12:37:54 volumio go-librespot[19821]: time="2025-11-03T12:37:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:55 volumio go-librespot[19821]: time="2025-11-03T12:37:55Z" level=debug msg="completed keyexchange" Nov 03 12:37:55 volumio go-librespot[19821]: time="2025-11-03T12:37:55Z" level=debug msg="completed challenge" Nov 03 12:37:55 volumio go-librespot[19821]: time="2025-11-03T12:37: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 03 12:37:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:37:55 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:55 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:58 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:37:58 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:37:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 780. Nov 03 12:37:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:37:58 volumio go-librespot[19828]: go-librespot daemon starting... Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=debug msg="app state loaded" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" 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 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" 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 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" 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 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=info msg="zeroconf server listening on port 36935" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=debug msg="obtained new client token: AAD04NJ5jm7rsHH5svS9C+a8M/Myb+eDpKHdwVhtQs6dtPnHN/rKIyh4XDCJ+43FoqJ3rvCKSDSLgFY9MXU9SC3IHF3NeKgnpOCGUrJYoK/FazVA5M2dlFi+AdT7H8vCsNPkopigA/RZjIyPJ9knpJh4Af+/mnhHIwJTubrV9O/Hc7L2+jHP1GKuqnNVCm6InE+h/KjIE1ydhCeJ8dW/xtH8uSSighjXQnbqCZEJjosRCLYX/BcwME4=" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=debug msg="completed keyexchange" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=debug msg="completed challenge" Nov 03 12:37:58 volumio go-librespot[19829]: time="2025-11-03T12:37:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:37:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:37:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:01 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:01 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 781. Nov 03 12:38:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:01 volumio go-librespot[19850]: go-librespot daemon starting... Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=debug msg="app state loaded" Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" 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 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" 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 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" 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 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=info msg="zeroconf server listening on port 33555" Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=debug msg="obtained new client token: AADzUax4WoBYe9RtZPd44hP1OGX2fKsZoX1rVtnmEULDYRfShQvIeVsXLLkSdK1dHbqhe8pKXktskgbvDsf73H6mJGoxeV9sF/fv1AbwGB6rAeiMceeQ7Z4YOwvKRY/ISrzFQvJvMishdV43FjFczoMZTWKHqd36qGheXvUMz7W2o+gJy54Grz3LH1YAHFN7gQEPcBm97m6j61SHdkDhgjJd3thgVX37IawsGthmg7xE41RsUtOSVkk=" Nov 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" 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 03 12:38:01 volumio go-librespot[19851]: time="2025-11-03T12:38:01Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 12:38:02 volumio go-librespot[19851]: time="2025-11-03T12:38:02Z" level=debug msg="completed keyexchange" Nov 03 12:38:02 volumio go-librespot[19851]: time="2025-11-03T12:38:02Z" level=debug msg="completed challenge" Nov 03 12:38:02 volumio go-librespot[19851]: time="2025-11-03T12:38: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 03 12:38:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:04 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:04 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 782. Nov 03 12:38:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:05 volumio go-librespot[19858]: go-librespot daemon starting... Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=debug msg="app state loaded" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" 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 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" 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 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" 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 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=info msg="zeroconf server listening on port 44583" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=debug msg="obtained new client token: AADtH5KvEVkZ0c1dMuG+3UHTBvY2escHstYkM1uTsJU3r9WiaOQCNk0CU8aTK54E7qR4ng2+e4hkHrFJig8PfgL8WnWHVVNGBVdrTZSS7KeYyrP8QhFW1KMNduvrU1hJYwiXlS9B9xhxvsS2MnP+n1f+JCiAZTPXEVTd+WnGzhm+YpSpsst2xjlcWHXUj8bZQ9tR68Y+nvQMzWhClaBvvBkgeHztcV7fz2k14WTVfM3ItchU8RIWCic=" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=debug msg="completed keyexchange" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=debug msg="completed challenge" Nov 03 12:38:05 volumio go-librespot[19859]: time="2025-11-03T12:38:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:07 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:07 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 783. Nov 03 12:38:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:08 volumio go-librespot[19866]: go-librespot daemon starting... Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" level=debug msg="app state loaded" Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" 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 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" 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 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" 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 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" level=info msg="zeroconf server listening on port 33023" Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" level=debug msg="obtained new client token: AADOgg+K6TdK2br5aFN1FeVVmqyTzWTbngBTlFh5XM3aVsofenB1IIZJyJtK3QFa3p0XbDFKTKrAOHynusOYwVicZhQXvUw5Wo41XVTGuF5mKfaf3/rZmaryl4agT+2St/2SjLMAub2nkv2tbj/SfdZU38PXZvpzQpbogLfYALMon4Seopdy8bV1xrradLlF08U7Tpub8RqdVOx+evP/PFcEut+WuTSQ1yACUltdFq8hfA2rnGnDymM=" Nov 03 12:38:08 volumio go-librespot[19867]: time="2025-11-03T12:38:08Z" 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 03 12:38:09 volumio go-librespot[19867]: time="2025-11-03T12:38:09Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 12:38:09 volumio go-librespot[19867]: time="2025-11-03T12:38:09Z" level=debug msg="completed keyexchange" Nov 03 12:38:09 volumio go-librespot[19867]: time="2025-11-03T12:38:09Z" level=debug msg="completed challenge" Nov 03 12:38:09 volumio go-librespot[19867]: time="2025-11-03T12:38: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 03 12:38:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:10 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:10 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 784. Nov 03 12:38:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:12 volumio go-librespot[19888]: go-librespot daemon starting... Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=debug msg="app state loaded" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" 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 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" 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 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" 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 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=info msg="zeroconf server listening on port 44051" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=debug msg="obtained new client token: AAAK1jRI8l2DMDsoxcOw3ZHzvmzexbc/K3g5/lYD29c6UKSgFEqqla3bQzadH4tGACfgKk6BkWGiOFZ7Ou0r8By7AZXFfVtPoxO2FoxMjPFmb5MFvFJVQZIkXMIApO/RRHw4Qtoa2MWJH1uesaqzLhQVkpPFn3HYrJQNSOruTNDFIN+x7MMgkeUBPrP4tCk/MVIu8X+mq8WJATYzy6QWnLFuSCnIJkpaohuRO6gvToyrIZRVdBZa1FA=" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=debug msg="completed keyexchange" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=debug msg="completed challenge" Nov 03 12:38:12 volumio go-librespot[19889]: time="2025-11-03T12:38:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:13 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:13 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 785. Nov 03 12:38:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:15 volumio go-librespot[19900]: go-librespot daemon starting... Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=debug msg="app state loaded" Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" 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 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" 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 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" 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 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=info msg="zeroconf server listening on port 43113" Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=debug msg="obtained new client token: AAB+l0HMFs44L7wIN9hoHTCHwhjjIEDniiCtEb+L0zG1HLozkge6thin3yfdBWK2/Wii41enbwMXYelQwgZ7v1muaBZFkxTLYPsIODFkOCElCCgW9D0DEMIxQd8b48fflNz7JRFHscr0STOJw1wZS/8KP7OhTOI++8pk9+zaJ604zxlTOyRkIccsMiX8QoL4d8OnAHCkZRETVzWNBEigozQkGieb2wwYd6S8OYOrqNFUscQuFodgHDs=" Nov 03 12:38:15 volumio go-librespot[19901]: time="2025-11-03T12:38:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:16 volumio go-librespot[19901]: time="2025-11-03T12:38:16Z" level=debug msg="completed keyexchange" Nov 03 12:38:16 volumio go-librespot[19901]: time="2025-11-03T12:38:16Z" level=debug msg="completed challenge" Nov 03 12:38:16 volumio go-librespot[19901]: time="2025-11-03T12:38: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 03 12:38:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:16 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:16 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:19 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:19 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 786. Nov 03 12:38:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:19 volumio go-librespot[19922]: go-librespot daemon starting... Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=debug msg="app state loaded" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" 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 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" 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 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" 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 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=info msg="zeroconf server listening on port 36029" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=debug msg="obtained new client token: AACrFwu9uIpLg4Fp4zI1sZdxtNvi/MvtxiPHH5VDEPBodiL3MJH9nZFlar2os54X4LGUZemwTAh4dLmaFYTJNwDp8h/swLhEgb0R9Yr0sWta/ofhWM/TB9OQtOp3jU4cDvfsnbNPi1LpGFHo4OAowRHy9uFY8jl7XVSYKbwSSaD7PkJvDUjLtu2LQ5vYMEdHYg5/Yl8WCodvcGpzHFyb3vQgXCeUFjFIh8d2l20d2EmG3bKvITWQXKM=" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" 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 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=debug msg="completed keyexchange" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=debug msg="completed challenge" Nov 03 12:38:19 volumio go-librespot[19923]: time="2025-11-03T12:38:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:22 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:22 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 787. Nov 03 12:38:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:22 volumio go-librespot[19931]: go-librespot daemon starting... Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=debug msg="app state loaded" Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" 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 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" 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 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" 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 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=info msg="zeroconf server listening on port 43609" Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=debug msg="obtained new client token: AADXQC/Z62nLTGFAgVKBTIdzsb/ft4JCGEp4FkIK4vdj5XzIJsGqGb0XOhGEto8683nf6gu5YtMZnxiSjsK3EmD/YTu4oGjyEg0ICwnlWn7KM9D0XxFmE2HGrOEpGVZdI4v3PFY/dYK+A2AlzZNIrq5z0CUJ0d7iky5UxEUAf57VT8NULUZ64KxuKbxENpMDqqCnRpBkgKA3aXMJLSQxOiiLDnIjaaGQgl3RvzxB/PTgDSPqlCO9iuE=" Nov 03 12:38:22 volumio go-librespot[19932]: time="2025-11-03T12:38:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:23 volumio go-librespot[19932]: time="2025-11-03T12:38:23Z" level=debug msg="completed keyexchange" Nov 03 12:38:23 volumio go-librespot[19932]: time="2025-11-03T12:38:23Z" level=debug msg="completed challenge" Nov 03 12:38:23 volumio go-librespot[19932]: time="2025-11-03T12:38: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 03 12:38:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:25 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:25 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 788. Nov 03 12:38:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:26 volumio go-librespot[19939]: go-librespot daemon starting... Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=debug msg="app state loaded" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" 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 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" 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 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" 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 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=info msg="zeroconf server listening on port 34323" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=debug msg="obtained new client token: AAD/vB/M+tGBy6cBfHNfVBlGKBVxtP69EEkP5HlaKnacOoHx1oUoU2z2u8XyTFrLPW6VCPlPWgspIwH58uutCxnjoeoi9tPnC2oy/lDphkzcUfHe7ALt1zdnROudysm+WdtBaGPRVl93+vqQqzBzQM+Eq+5ygyNNcdMQ38mCs0JkaETJbs467HLq8nmcfEKUDQoI0KUkThD2TBrOGGaWrTyEMn9j2R4kI5tzdhm0bTCTfeZoXnn/PXs=" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=debug msg="completed keyexchange" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=debug msg="completed challenge" Nov 03 12:38:26 volumio go-librespot[19940]: time="2025-11-03T12:38:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:28 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:28 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 789. Nov 03 12:38:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:29 volumio go-librespot[19961]: go-librespot daemon starting... Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=debug msg="app state loaded" Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" 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 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" 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 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" 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 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=info msg="zeroconf server listening on port 35167" Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=debug msg="obtained new client token: AADGlAzgyH009kOXw7LbGY0jyygqTqjV+R5tGq9ggWVxJsa8j836gm0rjQfgYputxWeG/vLyUsZ8vtpEUu8O3HmcdQvD23BHoeCu9yKTpjF0gJJXT9rcnSwWmXvFGoAuaL2/Mcg9B2izq9JQN3/C4rRfDFfAkUlqd+m7Nkuv8ejfvhl6/v1OL5oE3dAtaCKtNnqAib1NacYz54WSNR+JmBy6C7IOzgGUrxNYy31IPIxEKu5XHKVGSug=" Nov 03 12:38:29 volumio go-librespot[19962]: time="2025-11-03T12:38:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:30 volumio go-librespot[19962]: time="2025-11-03T12:38:30Z" level=debug msg="completed keyexchange" Nov 03 12:38:30 volumio go-librespot[19962]: time="2025-11-03T12:38:30Z" level=debug msg="completed challenge" Nov 03 12:38:30 volumio go-librespot[19962]: time="2025-11-03T12:38: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 03 12:38:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:31 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:31 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 790. Nov 03 12:38:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:33 volumio go-librespot[19970]: go-librespot daemon starting... Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=debug msg="app state loaded" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" 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 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" 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 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" 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 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=info msg="zeroconf server listening on port 36007" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=debug msg="obtained new client token: AADzbpbiSzQXSaw/Hyl23vXVEiKBHJ494uYF2cQxFg+VwQikYLe5ELEGYAtBxdO1b92fqQ2VVWBBq4uDBZiwfAkEfPnOwlRhUn4fcIryyxf5s3qG7KiwzI8GfBAnbTLks9hY5oIljv3I+yCz05IuhhDTAaz+lZ1FAn3FlFddfMfo8LI+qWbLniVKYFfcye7BG/S7MIvLoGa2T0qGMeCcfUAyEPvjieRv7/d0kV9h1S333G3Cl7W/NLY=" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=debug msg="completed keyexchange" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=debug msg="completed challenge" Nov 03 12:38:33 volumio go-librespot[19971]: time="2025-11-03T12:38:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:34 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:34 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 791. Nov 03 12:38:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:36 volumio go-librespot[19981]: go-librespot daemon starting... Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=debug msg="app state loaded" Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" 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 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" 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 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" 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 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=info msg="zeroconf server listening on port 39417" Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=debug msg="obtained new client token: AACqF4/uj5fC7AyHwShUnPa5YcrRBWTxSCCg4ZcJJwmpHY/7FiYld0874MCLFW6fOXi8/kIgd+YITTZD50akX0h/MwUCTwzT/OQ51eEIZhJrJZyj6NA74GzctI+ClpAAoZx3PMHl+AA8VFK5b2Y/NcEKGOTAMNF0N1dSCVVu8eXWe0H7Iy6iULU2f+NWvOdBhcxxK51+zkVVhVyRatuHw9+K4MzWbBTRm9PGJ/EyUv9vxL3mGufOBX8=" Nov 03 12:38:36 volumio go-librespot[19982]: time="2025-11-03T12:38:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:37 volumio go-librespot[19982]: time="2025-11-03T12:38:37Z" level=debug msg="completed keyexchange" Nov 03 12:38:37 volumio go-librespot[19982]: time="2025-11-03T12:38:37Z" level=debug msg="completed challenge" Nov 03 12:38:37 volumio go-librespot[19982]: time="2025-11-03T12:38: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 03 12:38:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:37 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:37 volumio volumio[19164]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:40 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Nov 03 12:38:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 792. Nov 03 12:38:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 12:38:40 volumio go-librespot[20016]: go-librespot daemon starting... Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=info msg="running go-librespot 0.4.0" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="app state loaded" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" 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 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" 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 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" 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 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=info msg="zeroconf server listening on port 38195" Nov 03 12:38:40 volumio volumio[19164]: info: Initializing connection to go-librespot Websocket Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="new websocket client" Nov 03 12:38:40 volumio volumio[19164]: info: Connection to go-librespot Websocket established Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="obtained new client token: AAAdWuln9xD4m95gn22AxDT46qKazscos94p0NLEHrxWE6EAzIZt5oK/GK3lf5u7+tPGlmAlOf6BalFLDOuVRlMcPNdEbTjq3EkWeUpQOEn12qupHAHAgOJEM9xIuMjD6b26cRFqjupB58cyzPNrOBkscwqq3zWls1zdSSZAv1baRZ7hcX0G32Qw4HYO46jGCnXEbqUFgZPd5xvQRVUPWzygWROvR6qhsQ1wkrv6LzWoesVWZ+EW" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="completed keyexchange" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=debug msg="completed challenge" Nov 03 12:38:40 volumio go-librespot[20017]: time="2025-11-03T12:38:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 12:38:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 12:38:40 volumio volumio[19164]: info: Connection to go-librespot Websocket closed Nov 03 12:38:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 12:38:40 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Nov 03 12:38:40 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Nov 03 12:38:43 volumio volumio[19164]: info: Getting Spotify volume Nov 03 12:38:43 volumio volumio[19164]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 12:38:43 volumio volumio[19164]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 12:38:43 volumio volumio[19164]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 03 12:38:43 volumio volumio[19164]: errno: -111, Nov 03 12:38:43 volumio volumio[19164]: code: 'ECONNREFUSED', Nov 03 12:38:43 volumio volumio[19164]: syscall: 'connect', Nov 03 12:38:43 volumio volumio[19164]: address: '127.0.0.1', Nov 03 12:38:43 volumio volumio[19164]: port: 9879, Nov 03 12:38:43 volumio volumio[19164]: response: undefined Nov 03 12:38:43 volumio volumio[19164]: } Nov 03 12:38:43 volumio volumio[19164]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 12:38:43 volumio sudo[20052]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 12:37' Nov 03 12:38:43 volumio sudo[20052]: 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"