Nov 04 02:28:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104.
Nov 04 02:28:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:01 volumio go-librespot[2588]: go-librespot daemon starting...
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=debug msg="app state loaded"
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" 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 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" 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 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=info msg="zeroconf server listening on port 36989"
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=debug msg="obtained new client token: AAD3dRw2f/z9xde2Swu8GZuQejReTA6oYjxTIWC9qN/xFF2vA2xbTth0d3swD0t+u4DwEp5MM9GiTGM95xqnHUNxfX2/EsicwnPZZvwEByKyEqcJSHm1DROgeZEmTYHE0YVqIzqg1o25qelpvbPG128LzaTCMz8zmlXZdwE50n+sjgyO8SFT2Kz23t3j1JqQPMERW9zDykUd9Ij0ZuivwgSZo+zeaZp7uM0HMdkdHGT4V0TXc214+tQ="
Nov 04 02:28:01 volumio go-librespot[2589]: time="2025-11-04T02:28:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:02 volumio go-librespot[2589]: time="2025-11-04T02:28:02Z" level=debug msg="completed keyexchange"
Nov 04 02:28:02 volumio go-librespot[2589]: time="2025-11-04T02:28:02Z" level=debug msg="completed challenge"
Nov 04 02:28:02 volumio go-librespot[2589]: time="2025-11-04T02:28: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 04 02:28:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:02 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:02 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105.
Nov 04 02:28:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:05 volumio go-librespot[2598]: go-librespot daemon starting...
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=debug msg="app state loaded"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28: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 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28: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 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28: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 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=info msg="zeroconf server listening on port 37183"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=debug msg="obtained new client token: AABuHWo2nciUnK9eTnxJCdAsEJdAXkTb7xV8CfTblgUlxwSzVPuvub9loGfz2zL1TpP/Tn38nXmzLBcY+gMphob3hiT2diMlNqTGtcYaT7tChhVAVBg2NpBiPGts1TvV56fmyjB6b5SC+QBpzsXWVF5jwlhPr10Apxz6jzwGt8Yozs7MRap02qjOSsTwko7Q/8QN23VENlzm3Uq5coKHro6/P4emsxDzSVpc2pMO4yvbFqR0YP/oAps="
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=debug msg="completed keyexchange"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28:05Z" level=debug msg="completed challenge"
Nov 04 02:28:05 volumio go-librespot[2599]: time="2025-11-04T02:28: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 04 02:28:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:05 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:05 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:08 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:08 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106.
Nov 04 02:28:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:08 volumio go-librespot[2609]: go-librespot daemon starting...
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=debug msg="app state loaded"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" 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 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" 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 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" 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 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=info msg="zeroconf server listening on port 43289"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=debug msg="obtained new client token: AABdZdvzYyJAobid5SzPE7pQDu6JsKS1XJ5kiIj4+r6sGjXyJMAugnzJYdxt9nXyQ+Tfbs4CLC5bFvWL8ExUdrSWSTIrwfrRpVLJhRFIizeVVGOn3axADA9rvQHV9Zc7lCGy/eSLpFmEWydFW0hQnktLZO4mOCq9XBEbyA/uAcVh+s+M/Tm6zTv/iM8aPlMOVYYKXGwz00K0Aokgeponk2qO8WSQguMLY18bNcbvberW8SAYNwiXIrc="
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=debug msg="completed keyexchange"
Nov 04 02:28:08 volumio go-librespot[2610]: time="2025-11-04T02:28:08Z" level=debug msg="completed challenge"
Nov 04 02:28:09 volumio go-librespot[2610]: time="2025-11-04T02:28: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 04 02:28:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:11 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:11 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107.
Nov 04 02:28:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:12 volumio go-librespot[2631]: go-librespot daemon starting...
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=debug msg="app state loaded"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28: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 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28: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 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28: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 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=info msg="zeroconf server listening on port 45701"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=debug msg="obtained new client token: AADq6BQGYexaEsrY7NcNJtsSk30LuayOHQdwhIy7Eq23QB7gEU8Wy1bHx0O1ik9wkXrSXPun0J7zfMvyxhs5xE3gTOxsPcPR7Zv4F1AKlIsxxXWeDKi/1DtIIP6GAPKBp0bgaO41uZUd7o/6TfKvLXkiatKelecJrgMA9z4X/Y2AxLfoHA4UH2GxFVInfoBGgW7Ao3XOi/Z+oQqXEV3lH/fS+eHsMM5Ye5hQnBDFB7CnUQoUpbtJAw4="
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=debug msg="completed keyexchange"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28:12Z" level=debug msg="completed challenge"
Nov 04 02:28:12 volumio go-librespot[2632]: time="2025-11-04T02:28: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 04 02:28:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:14 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:14 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108.
Nov 04 02:28:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:15 volumio go-librespot[2639]: go-librespot daemon starting...
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=debug msg="app state loaded"
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28: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 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28: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 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28: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 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=info msg="zeroconf server listening on port 41039"
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=debug msg="obtained new client token: AABS2vaqP6VYvQlaalWBoNTTEBvwmjnzuh1dBCD6yngdK7iRUsIXlp0JJ+U5f0YVhRn60Jv3ZfsAbsy3io4eKCrRQ9xdS0g47Rn2z3XNXzef0TPExYSnOSheR+Z5GHQPVdH2vL8e4p6z+1aH5PehGND3Oxys9DutFp0MBvZvL59HW6cZTxN858G4Z8HBzNYM9FUdz2TAqBhpQvi9Cux9vz87mU3uPj+go1m1q9XuPao9dbgaeJALF2Q="
Nov 04 02:28:15 volumio go-librespot[2640]: time="2025-11-04T02:28:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:16 volumio go-librespot[2640]: time="2025-11-04T02:28:16Z" level=debug msg="completed keyexchange"
Nov 04 02:28:16 volumio go-librespot[2640]: time="2025-11-04T02:28:16Z" level=debug msg="completed challenge"
Nov 04 02:28:16 volumio go-librespot[2640]: time="2025-11-04T02:28: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 04 02:28:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:17 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:17 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109.
Nov 04 02:28:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:19 volumio go-librespot[2647]: go-librespot daemon starting...
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=debug msg="app state loaded"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28: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 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28: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 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28: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 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=info msg="zeroconf server listening on port 44127"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=debug msg="obtained new client token: AAAP2ilCpML4UdTaz9gwA+ysoCEbBVblacxR3mYdt5oMYpGmHYMp6BuS6eeZ3uRLLnI3abnJAUj+VQJi5yPylGbFeNdoVjH/xc8n2qoCj2RKye343p7PN7KGsMCk7IJpnL0ZKGkTpc5BY/hKtGH6PCYgfyjJQ+qb9XgauAHUoqKk/f99NY5sCW5Ii4EASKlrAhaX8XiKU+5trxr5f0D/fO5/dcvewZ/9CZcVviuEsBJAYmbQOOdPwLE="
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=debug msg="completed keyexchange"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28:19Z" level=debug msg="completed challenge"
Nov 04 02:28:19 volumio go-librespot[2648]: time="2025-11-04T02:28: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 04 02:28:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:20 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:20 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110.
Nov 04 02:28:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:22 volumio go-librespot[2670]: go-librespot daemon starting...
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=debug msg="app state loaded"
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" 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 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" 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 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" 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 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=info msg="zeroconf server listening on port 42017"
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=debug msg="obtained new client token: AAB/45ycVuRcmCja5ONwCWd0yan81aO042R03DabIzMR44Ew78U4+S1OePjiO+QA9Hm+d8OKMl6Q2RI1WleMcd2qBpEeafUTtSouqzoPN2WoajOr04n+CuYsQgsXXZTuRvGY6eIzHYY3YS7jy3cvNA8u4GDcFrUtVgC/uS/+QGOt0KWvdIlg04BMUwhBYzGDuuf9uDleRTOEyQRiab9EiyQoozIaMyLT525vkg5d/AHy9ZnL8t5sVZU="
Nov 04 02:28:22 volumio go-librespot[2671]: time="2025-11-04T02:28:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:23 volumio go-librespot[2671]: time="2025-11-04T02:28:23Z" level=debug msg="completed keyexchange"
Nov 04 02:28:23 volumio go-librespot[2671]: time="2025-11-04T02:28:23Z" level=debug msg="completed challenge"
Nov 04 02:28:23 volumio go-librespot[2671]: time="2025-11-04T02:28: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 04 02:28:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:23 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:23 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111.
Nov 04 02:28:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:26 volumio go-librespot[2681]: go-librespot daemon starting...
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=debug msg="app state loaded"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" 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 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" 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 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=info msg="zeroconf server listening on port 33697"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=debug msg="obtained new client token: AAB9VL7wJ09ha8ANaQQ/ipXaWgfwkPyECg5AmcSp1ovJcxvkAwv1WOkw7NRep61bIlNUcrrfQtRIVga0XZ4PZgrMP/ML1JO9aYNBgA304pTR8zRBdJtpt1dIJqGXOA3kCscqY5cfyWL0YqMDiWHzKY0Fg0nFa7No0nCApq4ZoLBV4V2w9TSkFvSpcLpL3n8FM1N/PU+9OcEZRUoo90KW8ZdRzGowJCm/2LL9yMHtmRQVmf+PcOdWvbw="
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=debug msg="completed keyexchange"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28:26Z" level=debug msg="completed challenge"
Nov 04 02:28:26 volumio go-librespot[2682]: time="2025-11-04T02:28: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 04 02:28:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:26 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:26 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:27 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 04 02:28:29 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:29 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112.
Nov 04 02:28:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:29 volumio go-librespot[2689]: go-librespot daemon starting...
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=debug msg="app state loaded"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" 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 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" 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 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=info msg="zeroconf server listening on port 37135"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=debug msg="obtained new client token: AACZStFS7QF8el+7mm6aTUmXsjk8q2527uVBYA5vv0QDn0qAldhhhGy+N9Ed3Y6RKRymBJfZP4CrQXJ3EHkloi8xj0xd5NWHozAWs4mq7pkfEee9e4BbIN9ETYWpq7MpApIQDIffFt2DxbC2CgguY7HP++kfqiQW/cfQfhSTM2Da4QqFeGZ6h3JA4TykVHZYqamaS0M888nlnj34uq2ZNjo5Sf60Q2DRwl7hvdwaaA68oTAfNdxuefI="
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=debug msg="completed keyexchange"
Nov 04 02:28:29 volumio go-librespot[2690]: time="2025-11-04T02:28:29Z" level=debug msg="completed challenge"
Nov 04 02:28:30 volumio go-librespot[2690]: time="2025-11-04T02:28: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 04 02:28:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:32 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:32 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113.
Nov 04 02:28:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:33 volumio go-librespot[2712]: go-librespot daemon starting...
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=debug msg="app state loaded"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28: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 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28: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 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28: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 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=info msg="zeroconf server listening on port 42463"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=debug msg="obtained new client token: AABEji3t9vxOSL+/hoUWh7+dDwibrJWi0DUaspwO59NXiHFg5FPyZiI+g/PiibDyh+CNyV4eNKVIDiRjE0AugU3ONrIM1GPOfRRKRPddP4n2Egj5CAx3dckHXi+EYjxein5QeB+EUm3b2cQI+C+rMEaoCESarILSJSz/DSeUvNyJyJ9Zw9wLjj6MruSgnfmfYH2uZ+7u1A7hNoJ3MjY5S5gRT/KkQW2IU4Z9y+o5L5erTFL6RgWDswU="
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=debug msg="completed keyexchange"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28:33Z" level=debug msg="completed challenge"
Nov 04 02:28:33 volumio go-librespot[2713]: time="2025-11-04T02:28: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 04 02:28:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:35 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:35 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114.
Nov 04 02:28:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:36 volumio go-librespot[2721]: go-librespot daemon starting...
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=debug msg="app state loaded"
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28: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 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28: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 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28: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 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=info msg="zeroconf server listening on port 39767"
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=debug msg="obtained new client token: AAAKOkEe+MsUUoJD9VGGaOoKI5bwF8kNVwrvNhIiS5yVW3lsR5tWjIGcx2cThkemJZ1iwH8hSlCXpWcz8YF/u9Yes8/l4dj6Zdr3fsg1/TtZWQZibXPIwnGH/ufe9o8Kyw2HJqgZijyKdNk8U2/KYnE3loYt5VlLEmntu7bFKWHSBpUyiHVZxpJ9yX77PNsTzAI2eExqL72b2kt/jZr5NvlCH40fOb6HKub1PUL1YDoyxTOR4bN3cU4="
Nov 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" 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 04 02:28:36 volumio go-librespot[2722]: time="2025-11-04T02:28:36Z" level=debug msg="connected to ap-gew1.spotify.com:443"
Nov 04 02:28:37 volumio go-librespot[2722]: time="2025-11-04T02:28:37Z" level=debug msg="completed keyexchange"
Nov 04 02:28:37 volumio go-librespot[2722]: time="2025-11-04T02:28:37Z" level=debug msg="completed challenge"
Nov 04 02:28:37 volumio go-librespot[2722]: time="2025-11-04T02:28: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 04 02:28:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:37 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 04 02:28:38 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:38 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115.
Nov 04 02:28:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:40 volumio go-librespot[2744]: go-librespot daemon starting...
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=debug msg="app state loaded"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" 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 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" 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 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=info msg="zeroconf server listening on port 42263"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=debug msg="obtained new client token: AAA5XQiDjSBqkfejcRB+cqr+xQaOureslzeC42qwXwboDnCNBPfL7VFP3HCVjM5f4O+Oq89y5EUIsWj4l2EjMCJLXxO4uUiJPT6EawVs5Nro9sEK8zHZCab9nQmoxkmIM2Fu72qtnen+fnHUGyhwF3MIkrYqeMDhXg4MO2W2AVASe18BhFqthXOHDnhUCHsVmyy9vsIq77p0D8y2+V5/J0KdDk1ipwm6ryXIVFKv5/NleYucCIW6hJo="
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=debug msg="completed keyexchange"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28:40Z" level=debug msg="completed challenge"
Nov 04 02:28:40 volumio go-librespot[2745]: time="2025-11-04T02:28: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 04 02:28:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:41 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:41 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116.
Nov 04 02:28:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:43 volumio go-librespot[2754]: go-librespot daemon starting...
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=debug msg="app state loaded"
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" 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 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" 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 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" 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 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=info msg="zeroconf server listening on port 37691"
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=debug msg="obtained new client token: AADvKGg6xLtER2iR8nzM7s7BMukdR9HxcprQYF7jNF8ZV3BvUi/LP03K2jg4ssWnyGBjy2w0jC2dpJ4CkUBI4TxprWsIIGYJka1SIr5DIwerJ9ISDo0EdKDwam/mTVoZfh9hZB1C4OwB3Fy0PApoQLVvcQAmAZzTYjBNSWgSU6oX1Yk+pKUhdI2AkyxdtqvWU38kjLRMieAEuZKeV0w3PrK1Y40yWcVSCWeOLpk6iyYT2Y5wJ8y2fWA="
Nov 04 02:28:43 volumio go-librespot[2755]: time="2025-11-04T02:28:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:44 volumio go-librespot[2755]: time="2025-11-04T02:28:44Z" level=debug msg="completed keyexchange"
Nov 04 02:28:44 volumio go-librespot[2755]: time="2025-11-04T02:28:44Z" level=debug msg="completed challenge"
Nov 04 02:28:44 volumio go-librespot[2755]: time="2025-11-04T02:28: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 04 02:28:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:44 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:44 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117.
Nov 04 02:28:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:47 volumio go-librespot[2766]: go-librespot daemon starting...
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=debug msg="app state loaded"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28: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 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28: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 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28: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 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=info msg="zeroconf server listening on port 46705"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=debug msg="obtained new client token: AABy1g0xpX2M6YkqdpHjGeXOVinmQPiz0okvNjuUBbI5KBRTO0naC3Yle7gTsiyFvHVSHtxfXQinvabvo8dA6IVBYDz6KsYDzXp1KIWhUBrVzxCwMvEm080wsiZqefA5qMiewyqOHd5oKkW4ZV4fyugCyqZxjKkLNDJ4fUp3FqdbUxRVdVSG0aHWZMqYmbo+JBlmmabQPgHp8qpEWhbkBMWjLbC3urmB1LyBm2qRUHQpJqy2UrQS2/I="
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=debug msg="completed keyexchange"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=debug msg="completed challenge"
Nov 04 02:28:47 volumio go-librespot[2767]: time="2025-11-04T02:28:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 04 02:28:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:47 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:47 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:50 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:50 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118.
Nov 04 02:28:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:50 volumio go-librespot[2788]: go-librespot daemon starting...
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=debug msg="app state loaded"
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" 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 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" 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 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" 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 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=info msg="zeroconf server listening on port 42281"
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=debug msg="obtained new client token: AACav6XM8qigrVeRhEcguD6xOzTRI6gwQq+NgevqZk8/oCl42Oynb2uJ5S/j4vAkmqwTIUq5Sf0jJzTnE4R01EA2tLnR8GZVxU8h5cJRPHFoPC6fQDRrbKoGo/uiCOxFMKKUnQFnJyB+vud0sWStsGs00l+tex8tf6YW24bIZKNr7t+WgC0UqGYtyuVaMc4ZazG+f4xGEZHzVC+a4VBbG7k04I90nxe4Jp0FDOumj55SrfxpP6CxDLk="
Nov 04 02:28:50 volumio go-librespot[2789]: time="2025-11-04T02:28:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:51 volumio go-librespot[2789]: time="2025-11-04T02:28:51Z" level=debug msg="completed keyexchange"
Nov 04 02:28:51 volumio go-librespot[2789]: time="2025-11-04T02:28:51Z" level=debug msg="completed challenge"
Nov 04 02:28:51 volumio go-librespot[2789]: time="2025-11-04T02:28: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 04 02:28:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:52 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 04 02:28:53 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:53 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119.
Nov 04 02:28:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:54 volumio go-librespot[2796]: go-librespot daemon starting...
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=debug msg="app state loaded"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28: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 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28: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 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28: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 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=info msg="zeroconf server listening on port 37867"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=debug msg="obtained new client token: AACUkVruX91t5+5iTVml3pBt0o/5BSAV9363dy+66gpA98vUPc1bWUwS8jtC/1TyJHaq5ag1iEYyma+erD1wBH6NJu8h3KccjhBebmHQmilK2Z6FcCbTm8OnSGzEKmMtvv59Yw+lvD6etteBumyU4/uiO8cwM1JuoFH22X/MtwXDwX2gT7GTp2NB7F8ZUl/AngT7Asy338JG8SmANC2sBZpJIhmBEiVfXwRzy2inVG+bdTZuX/OAu9o="
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=debug msg="completed keyexchange"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=debug msg="completed challenge"
Nov 04 02:28:54 volumio go-librespot[2797]: time="2025-11-04T02:28:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 04 02:28:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:56 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:56 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:28:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120.
Nov 04 02:28:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:28:57 volumio go-librespot[2804]: go-librespot daemon starting...
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=debug msg="app state loaded"
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" 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 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" 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 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" 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 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=info msg="zeroconf server listening on port 45221"
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=debug msg="obtained new client token: AADmt6ojXZ4AfXqdH2fFGbkLvMftpQNDj5KLLMkEa5cb7oi14sKq4D4TKmunN4jmyMxI2WlziIVPlcxYM2zc7VWfYkPSo+c8AkHnUdQXkri+AsJqKcob9cCbC0c5V1hKzVULuQqiEZ8oN2Ztw9Ofw5c9MW1B9djcC0XLpoPw3CZ0wrhXKqc7z/8nheR4XwxJslehxbXREbNDKYJh4nGmH88KTHxz7cr04A3VSj+uaeuaFokayVlnqKQ="
Nov 04 02:28:57 volumio go-librespot[2805]: time="2025-11-04T02:28:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:28:58 volumio go-librespot[2805]: time="2025-11-04T02:28:58Z" level=debug msg="completed keyexchange"
Nov 04 02:28:58 volumio go-librespot[2805]: time="2025-11-04T02:28:58Z" level=debug msg="completed challenge"
Nov 04 02:28:58 volumio go-librespot[2805]: time="2025-11-04T02:28: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 04 02:28:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:28:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:28:59 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:28:59 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:29:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121.
Nov 04 02:29:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:01 volumio go-librespot[2827]: go-librespot daemon starting...
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=debug msg="app state loaded"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29: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-gae2.spotify.com:80]"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" 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 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" 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 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=info msg="zeroconf server listening on port 45159"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=debug msg="obtained new client token: AADra3dC2eNuEEwjCWJhVCG/mvp6hho/ziOxzRDeMsCRgvgh8yKp4ADgdVzWKld1XU+TVFiPqd359pnypHUALilPu8RtotzlRzQ7VJVvrGVfiTT7cyzEN6NWpBmaHpfaHI5jiporSn8ioX8htDOS346903sdVW+ZGpAcM/SaF0rew8xJrpPxMUEpxRpNt6RSoZGmo1O3DpIknwF15L+c/NTZ9038W1EX0n+BFz7gawXH/63FRosOiJg="
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=debug msg="completed keyexchange"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=debug msg="completed challenge"
Nov 04 02:29:01 volumio go-librespot[2828]: time="2025-11-04T02:29:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 04 02:29:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:29:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:29:02 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:29:02 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:29:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122.
Nov 04 02:29:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:04 volumio go-librespot[2837]: go-librespot daemon starting...
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=debug msg="app state loaded"
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" 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 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" 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 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" 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 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=info msg="zeroconf server listening on port 35093"
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=debug msg="obtained new client token: AAA9cnFDJECuvumqClhncEq2ck/I6TplHCk2KkZQaZeWuU7SYFn/79eIyh4JtE2n39opmxHPk06YBKiH2tjlUcwvSpXHU6BWCm2561/LadK/3PLvezD60GW3f/8VwRzTEjgAyjOB98Q+0pa7gCR+hcUN62cz35irzTBYs2jwVxCRFPCopIvJkfJRydMzD3UfwfqpvRCpkrk1HhCr+DvlXJihwl/8WLi9Y0AOEgKpQ6sFxKJtSOKTRFA="
Nov 04 02:29:04 volumio go-librespot[2838]: time="2025-11-04T02:29:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:29:05 volumio go-librespot[2838]: time="2025-11-04T02:29:05Z" level=debug msg="completed keyexchange"
Nov 04 02:29:05 volumio go-librespot[2838]: time="2025-11-04T02:29:05Z" level=debug msg="completed challenge"
Nov 04 02:29:05 volumio go-librespot[2838]: time="2025-11-04T02:29: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 04 02:29:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:29:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:29:05 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:29:05 volumio volumio[2053]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:29:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123.
Nov 04 02:29:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 04 02:29:08 volumio go-librespot[2848]: go-librespot daemon starting...
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=info msg="running go-librespot 0.4.0"
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=debug msg="app state loaded"
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" 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 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" 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 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" 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 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=info msg="zeroconf server listening on port 43993"
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=debug msg="obtained new client token: AABoPPdD0SZQ5CzhnyetzBqF86VZn29q825fZhC8q4pjUYSgs+z/4cLjFL9TsBT9RFH3baZoyIkCPWLcEWZ93d63K3Q8CDalXbUeU+gwBy5/AZRl6nfXDXUsFEpUaS8IO5fFaharKLgFtSA3NNgwGhS7dx29JGWxnisTT4c944X65fTYlpx3T2tTSrX59fRpzXMyD8TGk51qpg91S4K88a69y9tdeF9S8QUxk/8QRSWe8n0b3gY2Gco="
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 04 02:29:08 volumio volumio[2053]: info: Initializing connection to go-librespot Websocket
Nov 04 02:29:08 volumio go-librespot[2849]: time="2025-11-04T02:29:08Z" level=debug msg="new websocket client"
Nov 04 02:29:08 volumio volumio[2053]: info: Connection to go-librespot Websocket established
Nov 04 02:29:09 volumio go-librespot[2849]: time="2025-11-04T02:29:09Z" level=debug msg="completed keyexchange"
Nov 04 02:29:09 volumio go-librespot[2849]: time="2025-11-04T02:29:09Z" level=debug msg="completed challenge"
Nov 04 02:29:09 volumio go-librespot[2849]: time="2025-11-04T02:29: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 04 02:29:09 volumio volumio[2053]: info: Connection to go-librespot Websocket closed
Nov 04 02:29:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 04 02:29:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 04 02:29:09 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 04 02:29:11 volumio volumio[2053]: info: Getting Spotify volume
Nov 04 02:29:11 volumio volumio[2053]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 02:29:11 volumio volumio[2053]: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 04 02:29:11 volumio volumio[2053]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Nov 04 02:29:11 volumio volumio[2053]: errno: -111,
Nov 04 02:29:11 volumio volumio[2053]: code: 'ECONNREFUSED',
Nov 04 02:29:11 volumio volumio[2053]: syscall: 'connect',
Nov 04 02:29:11 volumio volumio[2053]: address: '127.0.0.1',
Nov 04 02:29:11 volumio volumio[2053]: port: 9879,
Nov 04 02:29:11 volumio volumio[2053]: response: undefined
Nov 04 02:29:11 volumio volumio[2053]: }
Nov 04 02:29:11 volumio volumio[2053]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 04 02:29:11 volumio sudo[2884]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-04 02:28'
Nov 04 02:29:11 volumio sudo[2884]: 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"