Nov 03 23:55:02 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:02 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Nov 03 23:55:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:02 volumio go-librespot[12722]: go-librespot daemon starting... Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=debug msg="app state loaded" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" 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 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" 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 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" 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 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=info msg="zeroconf server listening on port 43021" Nov 03 23:55:02 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 23:55:02 volumio volumio[12348]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 03 23:55:02 volumio volumio[12348]: info: CoreCommandRouter::volumioGetState Nov 03 23:55:02 volumio volumio[12348]: info: CorePlayQueue::getTrack 0 Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=debug msg="obtained new client token: AADMn3z2ZuLQzWPLDqgwPwedWlg+MdOgn6qHhLSsR1kvxk5+1FBw/OCyZ/sG9umlPAlU2f/gbUIi/68/zqityJgIf7icHihIw5BHb5rwGirHNXuJsCBay5MKDCBw/Ie/niKBvjOkvH6u5D3ooeaHleLmcnIoSpEf5o/YWlJFHvdydhZsIXnKBgqILnX3BJ3Irp/Z1PQDISFP1XrkE++2uEV87tVa1o4ZBqhNUcXziUfV5p1NrS5jIMk=" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=debug msg="completed keyexchange" Nov 03 23:55:02 volumio go-librespot[12723]: time="2025-11-03T23:55:02Z" level=debug msg="completed challenge" Nov 03 23:55:03 volumio go-librespot[12723]: time="2025-11-03T23:55:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:05 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:05 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Nov 03 23:55:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:06 volumio go-librespot[12730]: go-librespot daemon starting... Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="app state loaded" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=info msg="zeroconf server listening on port 44171" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="obtained new client token: AACn/lnSgIm3Fy74mS88XwboeedNyXdo0EFawVLXje1Ox6jwcNrBS9yCMdiIp+sV+RwozcO64vOsxZgDzqPXoZmJz/xDGGpW0or/QTJEgNTbfHFkCfDMubkP85WxQs6ARK727ZbL3htuauUt4UMv57P5EJtcwJLdz7vvthRdrIZsBrT5vk7A3E8BY/VS//0uj5V2bTVEYOAe+/LI7VMapomqZ6iWNrfx9D9WBo3VqhLXNfpRL9ZPgtI=" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="completed keyexchange" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55:06Z" level=debug msg="completed challenge" Nov 03 23:55:06 volumio go-librespot[12731]: time="2025-11-03T23:55: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 23:55:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 23:55:07 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 23:55:08 volumio volumio[12348]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 03 23:55:08 volumio volumio[12348]: info: Completed starting MyVolumio Plugin Nov 03 23:55:08 volumio volumio[12348]: [Metrics] CommandRouter: 32s 9.13ms Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::Close All Modals sent Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::Close All Modals sent Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 23:55:08 volumio volumio-remote-updater[874]: Test mode disabled Nov 03 23:55:08 volumio volumio-remote-updater[874]: Alpha mode disabled Nov 03 23:55:08 volumio volumio-remote-updater[874]: Alpha legacy test mode disabled Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 23:55:08 volumio volumio[12348]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 23:55:08 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 23:55:08 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:08 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:09 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 23:55:09 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 23:55:09 volumio volumio[12348]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 23:55:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Nov 03 23:55:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:09 volumio go-librespot[12761]: go-librespot daemon starting... Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=debug msg="app state loaded" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55: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-gae2.spotify.com:80]" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" 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 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" 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 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=info msg="zeroconf server listening on port 37995" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=debug msg="obtained new client token: AAAMMnXNIo0q1aeB7e67v24kyH13BUNcL5XW0P0RSi2lSBdcpHdAV7MNIId38hNnUhDbgDF2TeAIq1LL95WCMZSDNwAkQKSBUjHkc5UOczik7kk/AmlEUUV9D4PUEf9l9MSAde1MvIyT9miy7CSzGMmO+F0fhV9yCWSQCR6EGFcgVBrT2deF/6FDqI57NjYG17dKB7Lc8gd4d40fJ02bw1TIF1WazygipUP3rX298BX7brJGuI5HE1E=" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=debug msg="completed keyexchange" Nov 03 23:55:09 volumio go-librespot[12762]: time="2025-11-03T23:55:09Z" level=debug msg="completed challenge" Nov 03 23:55:10 volumio go-librespot[12762]: time="2025-11-03T23:55:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:11 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:11 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Nov 03 23:55:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:13 volumio go-librespot[12769]: go-librespot daemon starting... Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="app state loaded" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" 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 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" 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 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=info msg="zeroconf server listening on port 45635" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="obtained new client token: AACEIIZtWsp7OUOJyM4fO/FHSA3LzFD6ZFniU0icU5hBWbvA7yvg//fyOzqCAs9LXUMZiQFlA8560mB7B70rKAmMwGQ4IWvaad8t4t/apoVoAr0FCb/JxGPetGdtqUtMhRxMr0dp2fhAEBu3/CM3pHhg4gLs39cuubNzhUrpSqpZjs4JHq+SswTFJ6D1XAR0Jq9aB3YBjdcC3JixgBj3PnyM3fGra24jpeCZyTgqWjNcrM9djo8zxdk=" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="completed keyexchange" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55:13Z" level=debug msg="completed challenge" Nov 03 23:55:13 volumio go-librespot[12770]: time="2025-11-03T23:55: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 23:55:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:14 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:14 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:15 volumio volumio[12348]: info: BOOT COMPLETED Nov 03 23:55:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Nov 03 23:55:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:16 volumio go-librespot[12792]: go-librespot daemon starting... Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=debug msg="app state loaded" Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55: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 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55: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 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55: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 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=info msg="zeroconf server listening on port 35323" Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=debug msg="obtained new client token: AAB13oroMEkrj+zqsLVRe0r6kfpFgZopfaC+OkzQjc/Xn0R7ZgfR5gPnx4NgoIXS2avh8/K+kOcz+nIh2dXBkrD+lJ2p9GWsofCHR5/XVjBcIdqiJ0j7WD2awTcmm8lvuZGgI2GswNcjy5ZlaRmyXlvT9amv2L6lBFYi/ZRXN8gXO25nQdL88wmI9D04bYa/P+ajLyfw8EJH/NLy78ELOb5c1IlGDt0KlbLue9F7Nlif95dnrzrtBdo=" Nov 03 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" 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 23:55:16 volumio go-librespot[12793]: time="2025-11-03T23:55:16Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:55:17 volumio go-librespot[12793]: time="2025-11-03T23:55:17Z" level=debug msg="completed keyexchange" Nov 03 23:55:17 volumio go-librespot[12793]: time="2025-11-03T23:55:17Z" level=debug msg="completed challenge" Nov 03 23:55:17 volumio go-librespot[12793]: time="2025-11-03T23:55:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:17 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:17 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Nov 03 23:55:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:20 volumio go-librespot[12801]: go-librespot daemon starting... Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="app state loaded" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=info msg="zeroconf server listening on port 44515" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="obtained new client token: AADuGHFlXjwm66esIMkhfBMSW2AKJeMiNInFYnCtMWFilWvV6konxNv3TADC7Ui74QXWlBwBPTxrHUTTspymEGa/gS6s4Cq84nnjoWp61N8/IQnDT6rMzYjzrBLIRiTbPzIy/kVZ57qKQXDo9cCImBTCsRZNwCXGKoufems0LKX/It1VfxHL5UnqxzZHCI5rFldDiUpO6BWaB4RhTi0OdxBllHhk4zsrw8nHeI/ZM8FLMLGCzSGfSnw=" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="completed keyexchange" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55:20Z" level=debug msg="completed challenge" Nov 03 23:55:20 volumio go-librespot[12802]: time="2025-11-03T23:55: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 23:55:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:20 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:20 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:23 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:23 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Nov 03 23:55:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:23 volumio go-librespot[12812]: go-librespot daemon starting... Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=debug msg="app state loaded" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" 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 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" 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 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=info msg="zeroconf server listening on port 36419" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=debug msg="obtained new client token: AACpFtxediCLpTxr45RY+2jZjHYawh2D3ztQ+dxJuhLwbzlKK1ieV8V7Z5hoZ3klfXW+E2ZrkGL2ILubDhTm5h+/q9hWQ6XiTi+w28T0W3TcxZuLKSd5eMZrzDSPJpq0Zza4XdvTzDLGI9MSDYyVQFfOETmZKALeQBdPqW4LGl5d0V2x9JUK4ySIFfy2hDYmEdzad6WI7zmo/+jL3XlgHswepcOHZWINC2DNyaZeA0aWt95P+HJita4=" Nov 03 23:55:23 volumio go-librespot[12813]: time="2025-11-03T23:55:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:24 volumio go-librespot[12813]: time="2025-11-03T23:55:24Z" level=debug msg="completed keyexchange" Nov 03 23:55:24 volumio go-librespot[12813]: time="2025-11-03T23:55:24Z" level=debug msg="completed challenge" Nov 03 23:55:24 volumio go-librespot[12813]: time="2025-11-03T23:55:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:26 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:26 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Nov 03 23:55:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:27 volumio go-librespot[12834]: go-librespot daemon starting... Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="app state loaded" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=info msg="zeroconf server listening on port 45049" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="obtained new client token: AACU1g86e/dNxP3/69x46bvCti3CZgB6HZ0vbOHIWpsEkmbVZ4YV3EBsLoVYhm31Z8v0tyIEUz6+vflhBVtwtIv/1bgdWgJUnEZR5hVN+8qQvbJ5Ylr3oH0ciaAM5ibE8IHXaTU2PdGsILZjqUbxU1IM5z7bXvbyDbFGJOG0k5GuUjB5YQweW+0nsOca1DNoln4dYHVNHoeeb6IDFPLVX1ndA533DdtN7vFs+dyRGofePoVHq8f3PJU=" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="completed keyexchange" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55:27Z" level=debug msg="completed challenge" Nov 03 23:55:27 volumio go-librespot[12835]: time="2025-11-03T23:55: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 23:55:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:29 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:29 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Nov 03 23:55:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:30 volumio go-librespot[12843]: go-librespot daemon starting... Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=debug msg="app state loaded" Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" 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 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" 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 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" 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 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=info msg="zeroconf server listening on port 45623" Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=debug msg="obtained new client token: AADDrQOx0IbLRlhnO4RfrP1ZAlghQpgBKKCM0z5H2EQCCidLvnhUceKd85PHyzPCPotYS+IbJK3crFFhJq/OQaoN5hWC8hdVbLMdbTw7Ozle2DJpc/RA/lgS6NqrCCPyQbb6gT6pqKqDtmjwqR6uSSTV6E1py2QHpRmLhWh+eh8X5o8jPfYm+2yRRLYauK4szA5OE7sszaET5Ink5hBoB53xXety51W8scj06ye6MUDWP0B8lgkoviw=" Nov 03 23:55:30 volumio go-librespot[12844]: time="2025-11-03T23:55:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:31 volumio go-librespot[12844]: time="2025-11-03T23:55:31Z" level=debug msg="completed keyexchange" Nov 03 23:55:31 volumio go-librespot[12844]: time="2025-11-03T23:55:31Z" level=debug msg="completed challenge" Nov 03 23:55:31 volumio go-librespot[12844]: time="2025-11-03T23:55:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:32 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:32 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Nov 03 23:55:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:34 volumio go-librespot[12851]: go-librespot daemon starting... Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="app state loaded" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" 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 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" 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 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=info msg="zeroconf server listening on port 33257" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="obtained new client token: AAAZgaoO9h7zWed5nSrROMvfn286vpUsfvpZ8fUMSquO/PkjZTIPMACRsxTD2DxNEwz5K/EMEw6McT4hPgdXQ5lioa0BnE8Sf0Gfl8wPzNARun3xcVPbnIGytaWVyEBTFD8+veYgG1ohHsgzTP5FjIanpMUl4TG7NmnHTFlXioK8tzCxwFfLsWH1MbACd9R4U6n0XE+T4m40ersDf/i4zRdSQa4grEpOLpChLoFVERP9fOBaigkDpus=" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="completed keyexchange" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55:34Z" level=debug msg="completed challenge" Nov 03 23:55:34 volumio go-librespot[12852]: time="2025-11-03T23:55: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 23:55:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:35 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:35 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Nov 03 23:55:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:37 volumio go-librespot[12874]: go-librespot daemon starting... Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=debug msg="app state loaded" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55: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-gew4.spotify.com:80]" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" 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 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" 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 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=info msg="zeroconf server listening on port 38121" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=debug msg="obtained new client token: AAChWW7zugHYEbdu0GnT9eNrsUQ0oRoAYovN8CS9GJD2umQVMXZdPe+2SCxinPCgxCz5bG7TKiChTK7Hd2PQapI2mjvD958Xh78HbQz+ZZSCmrybF0VQgSVLLay6AMBimMgxC/xWby8BbauvMUByirWioTIOaeph+TD8EINcXsXKXYz8+Imqg37iMGnyVbp45pSiu02wOI1/COJdqXTc23aTlH4Wb1vTDRjGoImxkzHDMktdLSeYEz4=" Nov 03 23:55:37 volumio go-librespot[12875]: time="2025-11-03T23:55:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:38 volumio go-librespot[12875]: time="2025-11-03T23:55:38Z" level=debug msg="completed keyexchange" Nov 03 23:55:38 volumio go-librespot[12875]: time="2025-11-03T23:55:38Z" level=debug msg="completed challenge" Nov 03 23:55:38 volumio go-librespot[12875]: time="2025-11-03T23:55:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:38 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:38 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:41 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Nov 03 23:55:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 03 23:55:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:41 volumio go-librespot[12903]: go-librespot daemon starting... Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="app state loaded" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:41 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Nov 03 23:55:41 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=info msg="zeroconf server listening on port 34391" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="obtained new client token: AAAy6eBma2bHWsHKDWGEqTMXXV9EpbUlMlezVBU8NvhiyRM8dok3ev6ytCwzfejksKt2AKcjg7d5rC5RG24avblX/4agogC6OaibMeaop6RoBcZh6+5te0saQXyYFXFUhl2FQzAddSiwa2NIY1NKGDwihifgTpJgfmYcYBxOTuuNiafNkasiaX6BytCuGXGRN1V8RQiMsCFeBYyNgNVrQGc0sxU3lIxdEPClYlYHowBIiMfY6vmXyjo=" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="completed keyexchange" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55:41Z" level=debug msg="completed challenge" Nov 03 23:55:41 volumio go-librespot[12904]: time="2025-11-03T23:55: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 23:55:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:41 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:41 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:44 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:44 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 03 23:55:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:44 volumio go-librespot[12918]: go-librespot daemon starting... Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=debug msg="app state loaded" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55: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 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55: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 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55: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 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=info msg="zeroconf server listening on port 37161" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=debug msg="obtained new client token: AACgRQ+uG6L8USU3uYM/OYYOXki+0ZYR9j8X6IiVRmeFivWfLmdeNCROma1UQlf8F3fjL3Om2qHtCPhDCszfk6iDEBrejYvmMqoQ6h9tNrD9zfV7zPInnn02IUaGedr/JTzvzu4mPoFvdFaaZjqn8B2h+rbOVaaOmFBfVXtcSEiqpHkw9y9RlbflTZx/7MQf8W1dt+ySbPPzYpjShhm+AvxHMT7ghGZMvBk7+G352oAFEqo3qI8K/Mc=" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=debug msg="completed keyexchange" Nov 03 23:55:44 volumio go-librespot[12919]: time="2025-11-03T23:55:44Z" level=debug msg="completed challenge" Nov 03 23:55:45 volumio go-librespot[12919]: time="2025-11-03T23:55:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:47 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:47 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 03 23:55:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:48 volumio go-librespot[12940]: go-librespot daemon starting... Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="app state loaded" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=info msg="zeroconf server listening on port 36799" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="obtained new client token: AACN4AckgKjBDsqI5hGZ6zFxOYGeqm/a6O0rS2mMuFWd16RGtiAiHEu+EyQtI6CWIVNIxLmmv7Ty9Q0JIBGlkrWxRvdH9bNy04P7dqxnq7ajX3AEk4Wg7sqgOmRLh1u9hEpFhYKbi5oF+ttUB0TvZTpEK2hDsWePVAZmmxruU6/7Ptgut1IlU5DRshL6Y605hlaz9BNi3DppAcp6BaDYTJm/vrrAkx0I8TXZddbf3+PKkX9enTcQ2kM=" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="completed keyexchange" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55:48Z" level=debug msg="completed challenge" Nov 03 23:55:48 volumio go-librespot[12941]: time="2025-11-03T23:55: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 23:55:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:50 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:50 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 03 23:55:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:51 volumio go-librespot[12948]: go-librespot daemon starting... Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=debug msg="app state loaded" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" 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 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" 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 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=info msg="zeroconf server listening on port 33309" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=debug msg="obtained new client token: AADngHCpP796VqTxCc8mhlD3i57J5Q4/Dt4+iZzS6DvNJCRmaGeUfrmvcTFSEP0rGJusYFRVzmgiuXqKiokFpEcv8XPKF/M4KtqMIHZhnCgxFlLrEIEBAyK9xcHeRK5NGiXf1PcG0ZmQBT7qhKYMsz6DVV2WZRRpWeebVWZ9lp6QHhA9+9P7aMMq8fFnaX4+hOGMiO3Q7gCNi1n97JBL+aB71oDF0+3bVSrPca54kMCluFCCKboW/RM=" Nov 03 23:55:51 volumio go-librespot[12949]: time="2025-11-03T23:55:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:52 volumio go-librespot[12949]: time="2025-11-03T23:55:52Z" level=debug msg="completed keyexchange" Nov 03 23:55:52 volumio go-librespot[12949]: time="2025-11-03T23:55:52Z" level=debug msg="completed challenge" Nov 03 23:55:52 volumio go-librespot[12949]: time="2025-11-03T23:55:52Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:53 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:53 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Nov 03 23:55:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:55 volumio go-librespot[12956]: go-librespot daemon starting... Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="app state loaded" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" 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 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" 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 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=info msg="zeroconf server listening on port 46473" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="obtained new client token: AACghVSyIuajy6etX1byTa1oTZKXTpX3EcJHMngzbjYkLL5oFn0x/OTWHVuZeirXoLB2iLgP6xsCu8Bm6szf+XIywFvp67e8g0VTMc7gzBaDIxVY9ai3HwrmpR7XGKQXD0+cIHTgOT7p/1OuH3qKYgjOLxJU/F+hLq4iYUc2AoQVOLRUg1m2NK8269xejaXPChe3LXdUhPy5/DZJrln7UOk9Y60BTjdIrB3HaS9hbm7pCcW2VeadYwI=" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="completed keyexchange" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55:55Z" level=debug msg="completed challenge" Nov 03 23:55:55 volumio go-librespot[12957]: time="2025-11-03T23:55: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 23:55:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:56 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:56 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:55:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Nov 03 23:55:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:55:58 volumio go-librespot[12978]: go-librespot daemon starting... Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=debug msg="app state loaded" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" 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 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" 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 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=info msg="zeroconf server listening on port 33921" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=debug msg="obtained new client token: AAD9KN9o70kHTlaB5mxZt5BifneiAD7X3UDFXa+9BofsuC7qo08j3DzAYm8VaztnTCKQnl7IXEMUtX3W1f9hCmEV6yuDfIw17YDtgI3lwWCL9to5/YxEpwv48lRigRWY70CiNzNisaSPS6zjQNmBfcz6elo2P2gqX04JTVIiG+8vfjRsTdF6eJfUB3/OHi+dAKWo7NSu7tpRGInjENe/HombcZhtSIuI74TQWUq4/eXQpdpxmS4tV2s=" Nov 03 23:55:58 volumio go-librespot[12979]: time="2025-11-03T23:55:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:55:59 volumio go-librespot[12979]: time="2025-11-03T23:55:59Z" level=debug msg="completed keyexchange" Nov 03 23:55:59 volumio go-librespot[12979]: time="2025-11-03T23:55:59Z" level=debug msg="completed challenge" Nov 03 23:55:59 volumio go-librespot[12979]: time="2025-11-03T23:55:59Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:55:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:55:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:55:59 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:55:59 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Nov 03 23:56:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:02 volumio go-librespot[12989]: go-librespot daemon starting... Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="app state loaded" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=info msg="zeroconf server listening on port 39109" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="obtained new client token: AACSx/geA86mUoAiejU5pqkk4EhUOwgErPotHokmQbzg5XL6HMKxiR4u7F5hVcNjFn9C5wTYM7PPANSlwgdgsZCZiXao5hijwxhEF+jDtKkajshwQzLIFUfhCeJJNdrL8C/XgXzWtVjqmqOta7U9ZKrhVKX9Fx924wnpeU1pkQRGH/ZomHb7nunEIcM4njYoXtucsPewAco3m0ZKB91Fm01t1oqAPHxJeDd3dGoY0DfKFpMstBGg7Do=" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="completed keyexchange" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56:02Z" level=debug msg="completed challenge" Nov 03 23:56:02 volumio go-librespot[12990]: time="2025-11-03T23:56: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 23:56:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:02 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:02 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:05 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:05 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Nov 03 23:56:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:05 volumio go-librespot[12998]: go-librespot daemon starting... Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=debug msg="app state loaded" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56: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-gae2.spotify.com:80]" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" 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 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" 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 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=info msg="zeroconf server listening on port 46637" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=debug msg="obtained new client token: AACQerJ+cgQf9XAA/hnnCZK1XlHySMrIfPyqvN0vLMLay0QaVEVmKul7Uckt7A6Ix5ZUx6kHS0o9hveMY4aYlBhY1T9GTw/kuB0Gea6SZbwqmZYQ0jwNU+VMockofNAjT9abStDpSd5xCl7z/KWFZ2IJu4h5/FPlYajD9UIrOMRDwRr15tzV1UVapfli5zbNe0KmnWaqmUEBa68E1VwoxYHuioroFb+Q4s877mvDP5IAe2f9QO3mnN8=" Nov 03 23:56:05 volumio go-librespot[12999]: time="2025-11-03T23:56:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:06 volumio go-librespot[12999]: time="2025-11-03T23:56:06Z" level=debug msg="completed keyexchange" Nov 03 23:56:06 volumio go-librespot[12999]: time="2025-11-03T23:56:06Z" level=debug msg="completed challenge" Nov 03 23:56:06 volumio go-librespot[12999]: time="2025-11-03T23:56: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 23:56:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:08 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:08 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Nov 03 23:56:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:09 volumio go-librespot[13020]: go-librespot daemon starting... Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="app state loaded" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=info msg="zeroconf server listening on port 43131" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="obtained new client token: AACnr8wfaf/9uumUTd12xq3kqimpICeDK6b7F+4jGB8WAET/wEfE2rB71lA8eObN4VhEZIobN4e/mqwUK2sWWsZfxgekYoCLoSeOr5U6o0K08IWRUp4gTp3eKSLq53PHD/k32Ao+MdkpCCCetEp9Kec8qRuOWXSXIDQkFrogcRZs8h2CmLySnFUwXyX/BVPAzOXF3vICQWQyiUyOJjRDTmhom8+xLB45MwiltbTHYmzOKOYjubIgi2c=" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="completed keyexchange" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56:09Z" level=debug msg="completed challenge" Nov 03 23:56:09 volumio go-librespot[13021]: time="2025-11-03T23:56: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 23:56:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:11 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:11 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Nov 03 23:56:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:12 volumio go-librespot[13029]: go-librespot daemon starting... Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=debug msg="app state loaded" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56: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 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56: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 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56: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 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=info msg="zeroconf server listening on port 34415" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=debug msg="obtained new client token: AAB6dYlFHZCcG7NNMGO6Hr/o5JRw0iFv2+2U3A03bCJlxOzURLF+ngvwU76HlEndK/lsvVnlqlaY19c5BEcAlRw2fTSsVsDN3smrGYtpPb7N9BDpFx20AgrJo1kmHhpLFnDLyxOdD4Qn/HnJAELiOkQGxC3FQu8ba8ZrM9ytzOrKRXEPXhl5QBzj7uqDfm0ZXaaTNVQC1WNzEYlUUqqn/8PqFdmegHYxI34+6eV2wHahTY4kvbZqzdU=" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=debug msg="completed keyexchange" Nov 03 23:56:12 volumio go-librespot[13030]: time="2025-11-03T23:56:12Z" level=debug msg="completed challenge" Nov 03 23:56:13 volumio go-librespot[13030]: time="2025-11-03T23:56: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 23:56:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:14 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:14 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Nov 03 23:56:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:16 volumio go-librespot[13038]: go-librespot daemon starting... Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="app state loaded" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=info msg="zeroconf server listening on port 39753" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="obtained new client token: AADOFozBw5z7JVXJQYzdl9Gkb1UeB10glCnuv7YfKU2Pp0DxWD5GnFtsxN0cfm9rYFybyaLWEm6Wo6zaPBP+Wpd8GeKWH9PBM8YYSnRI5fM1L/ogPkhUN2RzgHH2PjuqjrgKN2Nz4XmDLs355BzhN598XGxdrPqetPNwZLKaxsVuoS4+qBh85HSii1UCYmYUGpOMF6F4R/Ja5AznKGcjlzvHRZyjDpmelPPQSLNPlHZrUMm5AxEvnJQ=" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="completed keyexchange" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56:16Z" level=debug msg="completed challenge" Nov 03 23:56:16 volumio go-librespot[13039]: time="2025-11-03T23:56: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 23:56:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:17 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:17 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Nov 03 23:56:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:19 volumio go-librespot[13060]: go-librespot daemon starting... Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=debug msg="app state loaded" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56: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-gew4.spotify.com:80]" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" 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 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" 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 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=info msg="zeroconf server listening on port 37809" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=debug msg="obtained new client token: AAClWw+JXK56R15i8A5tQ7KvNGRgJocgvFsN6JBI3nNFTLKDn2BBt840tn0mOTSFJjvkHuv6wK2qk0SnLFa8al07JjGgtHS57qnU1T2M1IBk75KhhRG0TkvSusmSkQVywYo6JhwE8fjtN5f9vP3RC358+ncfdFktALYcmTvJXgeq+09kYDM/knZu02J0nzt40sqwvq9ybjD4H2Zwt9wcZ1R3Wb3tqciZyrP5DegT7r1ijjLANap9m14=" Nov 03 23:56:19 volumio go-librespot[13061]: time="2025-11-03T23:56:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:20 volumio go-librespot[13061]: time="2025-11-03T23:56:20Z" level=debug msg="completed keyexchange" Nov 03 23:56:20 volumio go-librespot[13061]: time="2025-11-03T23:56:20Z" level=debug msg="completed challenge" Nov 03 23:56:20 volumio go-librespot[13061]: time="2025-11-03T23:56: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 23:56:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:20 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:20 volumio volumio[12348]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:56:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Nov 03 23:56:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:56:23 volumio go-librespot[13072]: go-librespot daemon starting... Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=debug msg="app state loaded" Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56: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 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56: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 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56: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 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=info msg="zeroconf server listening on port 44979" Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=debug msg="obtained new client token: AAA0O3Y7Q/bRbAbd6x7EVBveOL5zGfqWZKtwd6Dba7Ae7c/DKXCXoHBZMqkN8GFeB/06jcjgHpvdYdguHO2d7r7NDHWgZssHGir7PYnF1DKkHnGs2VDtufDdznB/fmb23X2T0y8WIkiL52TQm4OWdKkV0LPF34KE/n5dx2wYwzQ7D4E90BSl6hN0ElwbUshsKkgcqgLJ1FtroY29uoOh3+9ErOmy2v7FUfek3m+jNPVzHA+zBh3770U=" Nov 03 23:56:23 volumio volumio[12348]: info: Initializing connection to go-librespot Websocket Nov 03 23:56:23 volumio go-librespot[13073]: time="2025-11-03T23:56:23Z" level=debug msg="new websocket client" Nov 03 23:56:23 volumio volumio[12348]: info: Connection to go-librespot Websocket established Nov 03 23:56:26 volumio volumio[12348]: info: Getting Spotify volume Nov 03 23:56:26 volumio volumio[12348]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 03 23:56:26 volumio volumio[12348]: info: CoreCommandRouter::volumioGetState Nov 03 23:56:26 volumio volumio[12348]: info: CorePlayQueue::getTrack 0 Nov 03 23:56:26 volumio volumio[12348]: SPOTIFY: RECEIVED VOLUMIO VOLUME 33 Nov 03 23:56:26 volumio volumio[12348]: SPOTIFY: SPOTIFY VOLUME undefined Nov 03 23:56:26 volumio volumio[12348]: SPOTIFY: VOLUMIO VOLUME 33 Nov 03 23:56:26 volumio volumio[12348]: info: Aligning Spotify Volume to Volumio Volume Nov 03 23:56:26 volumio volumio[12348]: info: CoreCommandRouter::volumioGetState Nov 03 23:56:26 volumio volumio[12348]: info: CorePlayQueue::getTrack 0 Nov 03 23:56:26 volumio volumio[12348]: info: Setting Spotify Volume from Volumio: 33 Nov 03 23:56:26 volumio go-librespot[13073]: time="2025-11-03T23:56:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:56:26 volumio go-librespot[13073]: time="2025-11-03T23:56:26Z" level=debug msg="completed keyexchange" Nov 03 23:56:26 volumio go-librespot[13073]: time="2025-11-03T23:56:26Z" level=debug msg="completed challenge" Nov 03 23:56:26 volumio go-librespot[13073]: time="2025-11-03T23:56: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 23:56:26 volumio volumio[12348]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 23:56:26 volumio volumio[12348]: Error: socket hang up Nov 03 23:56:26 volumio volumio[12348]: at connResetException (node:internal/errors:720:14) Nov 03 23:56:26 volumio volumio[12348]: at Socket.socketOnEnd (node:_http_client:519:23) Nov 03 23:56:26 volumio volumio[12348]: at Socket.emit (node:events:526:35) Nov 03 23:56:26 volumio volumio[12348]: at endReadableNT (node:internal/streams/readable:1376:12) Nov 03 23:56:26 volumio volumio[12348]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Nov 03 23:56:26 volumio volumio[12348]: code: 'ECONNRESET', Nov 03 23:56:26 volumio volumio[12348]: response: undefined Nov 03 23:56:26 volumio volumio[12348]: } Nov 03 23:56:26 volumio volumio[12348]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 23:56:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:56:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:56:27 volumio sudo[13108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 23:55' Nov 03 23:56:27 volumio sudo[13108]: 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"