Oct 28 10:58:01 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:01 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 408. Oct 28 10:58:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:01 volumio go-librespot[12579]: go-librespot daemon starting... Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=debug msg="app state loaded" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58: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]" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58: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]" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58: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]" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=info msg="zeroconf server listening on port 42657" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=debug msg="obtained new client token: AAAZyF74rCwHz7nVeaeVG7omByhEI/qNYPcm5Y3w9JjEIJPHKQEMNMJhoyVJ2w6BYrvtxn/+PCV+C0izSkzsk533gf3cpYIZSoGwgiLrO0eVAmWc821Dxtv0mEClYZ6gjkSBRMln0CtqBPTl355mcuFc037zPLk/oEHtJDOHuWflzicyTyhfeWImuK+EtgFgseLVLsS5vY/XAlbS/BlIDlWTls5fvEYMWqGUlWuXMlmbs1yDpQVvY80=" Oct 28 10:58:01 volumio go-librespot[12580]: time="2025-10-28T10:58:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:02 volumio go-librespot[12580]: time="2025-10-28T10:58:02Z" level=debug msg="completed keyexchange" Oct 28 10:58:02 volumio go-librespot[12580]: time="2025-10-28T10:58:02Z" level=debug msg="completed challenge" Oct 28 10:58:02 volumio go-librespot[12580]: time="2025-10-28T10:58:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:04 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:04 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 409. Oct 28 10:58:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:05 volumio go-librespot[12587]: go-librespot daemon starting... Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="app state loaded" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=info msg="zeroconf server listening on port 41149" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="obtained new client token: AAAXVBfYrD0ypgajvMUVqebOpjmBbtzuG1De/t3YYVSy73zlmiHDUb9PCH9ga6DmYap6DICRHplFpvgaZj8bokWE0K6YOQLQq1N2AJklWruOeug7Mrj5L6K14UuN1OYPWAdnDqkcmrYXPbdCPi5uaNskB2fb8Q4EJL1YM4Yk1N2+CbJLCpLVgN9Z615KEDylb/r364XlrqqGSyNer7QXIP/PLKhmxQQEJMsfxrN5czOqqrsfKky8tYo=" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="completed keyexchange" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=debug msg="completed challenge" Oct 28 10:58:05 volumio go-librespot[12588]: time="2025-10-28T10:58:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:07 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:07 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 410. Oct 28 10:58:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:08 volumio go-librespot[12595]: go-librespot daemon starting... Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="app state loaded" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=info msg="zeroconf server listening on port 43873" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="obtained new client token: AAAjrNo3fcT7FrJVYARKeZPPcV5006+JEithRhTs/dSt6NChG4KUj8v0GwhidvlKDIRu+At4WWjVqNT6u37YgPBl6taEXIhd5M8ZaKE0FZXRtk0t64iz4Wsq0Y2IwOFe3ieW1dk3X1M5E/vJGKlkUnXLlsA33RaYG/NjegFJtY3oSTetizLlziJJ+6PMdcIAoldd/Ka86gsW6DeGF/kKoAX1W5z3Hy1XdL2G+7CNrcipdnfvJ/qc/50=" Oct 28 10:58:08 volumio go-librespot[12596]: time="2025-10-28T10:58:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:09 volumio go-librespot[12596]: time="2025-10-28T10:58:09Z" level=debug msg="completed keyexchange" Oct 28 10:58:09 volumio go-librespot[12596]: time="2025-10-28T10:58:09Z" level=debug msg="completed challenge" Oct 28 10:58:09 volumio go-librespot[12596]: time="2025-10-28T10:58:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:10 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:10 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 411. Oct 28 10:58:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:12 volumio go-librespot[12617]: go-librespot daemon starting... Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="app state loaded" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58: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-gae2.spotify.com:80]" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=info msg="zeroconf server listening on port 38501" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="obtained new client token: AABIYEHAUZYjFwyVjZdEuFa65i6Ji30fGMdmM1sAGKYMXEc5XpiRv/NmGp6c2vnDNQbjsCz6CJoRXuMq00rVS4OLVEf3d7hCxuvtR0z6LUSMyXL1H5U3HUweMgOeNGN9lEku9IiuhGZ8M/pGcUfiebeUdV6/RFeEmy74LUYyr8lgijI0Wy8MzTneLz1fsI6C4MBUwZU6vmQVY1gfHzp+CsomUOUoYLNNFC15KK1yL2HDumcS6xFx2Vg=" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="completed keyexchange" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=debug msg="completed challenge" Oct 28 10:58:12 volumio go-librespot[12618]: time="2025-10-28T10:58:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:13 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:13 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 412. Oct 28 10:58:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:15 volumio go-librespot[12629]: go-librespot daemon starting... Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=debug msg="app state loaded" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=info msg="zeroconf server listening on port 33727" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=debug msg="obtained new client token: AAAJiWr1ipxvaJIqbAzCoEYJeG2pZAGG3/s++Agp/w+m6KLxEVqmXR14rTBNFxKkHfBUYFm26i8jEUz+c958Vp2t6cwcTk0BUbxcWG75nEZhzfYlK0MTGiufLLyo8XEMT4+FqWEaY/3dRYzO7+Xtb7+NRpVXtMCwgyjmMBivIWapzLq3mqFlAFF/KmzpncYdv9yDAnq236I30fu98C6KcpOychRAU4sWCLBn9FTaFSarX0uC/+BG7B4=" Oct 28 10:58:15 volumio go-librespot[12630]: time="2025-10-28T10:58:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:16 volumio go-librespot[12630]: time="2025-10-28T10:58:16Z" level=debug msg="completed keyexchange" Oct 28 10:58:16 volumio go-librespot[12630]: time="2025-10-28T10:58:16Z" level=debug msg="completed challenge" Oct 28 10:58:16 volumio go-librespot[12630]: time="2025-10-28T10:58:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:16 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:16 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 413. Oct 28 10:58:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:19 volumio go-librespot[12652]: go-librespot daemon starting... Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="app state loaded" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=info msg="zeroconf server listening on port 40699" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="obtained new client token: AAC3J8SvZBKYik4MLtSo+8WgvVWJfUObA4Dj7cxJ5Z+CvZ6t/sT2WzbahDK64W61aSG1SU4gTBv6Oc10JRb8yKBcCoCoMZhg+vWJe0xj/VIFlJ3O0amqwLccPHSRkCzZS4NPg6JRiTHsHdXCs2WDSG+ccNF2rEvOua3ve0vkrzOBjUOSJD90oGyJC9Yut5JvumhQA5GLd5fS6YvjBvbLb+mz+6r8hIALSaH/HJoEgQ9NoaJe92pGoZI=" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="completed keyexchange" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=debug msg="completed challenge" Oct 28 10:58:19 volumio go-librespot[12653]: time="2025-10-28T10:58:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:19 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:19 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:22 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:22 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 414. Oct 28 10:58:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:22 volumio go-librespot[12661]: go-librespot daemon starting... Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=debug msg="app state loaded" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=info msg="zeroconf server listening on port 37599" Oct 28 10:58:22 volumio go-librespot[12662]: time="2025-10-28T10:58:22Z" level=debug msg="obtained new client token: AAAK9YH4NOtKHvf/YSxr4c0hnr/qQmQj7y01WbcKB/HRitYAhyDGAWFs0qNXQL6Wrl7j4HTLDmplsfv/yTOxJhnYjI4uZI9A/FpjaNkfwpjsh5j+Mq2HmRYSW7FLRhShDchMt6Mk1l7+3cGkHOAhMPNK0GhhJL8N32Yq2amXWtLh+o+6Ny5nBm/CPcrOVhxN9d5cXh9bJhsscZmKaWae8lggjeOdbNsz4T8E65NFrCfkc8yIkIO8ATk=" Oct 28 10:58:23 volumio go-librespot[12662]: time="2025-10-28T10:58:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:23 volumio go-librespot[12662]: time="2025-10-28T10:58:23Z" level=debug msg="completed keyexchange" Oct 28 10:58:23 volumio go-librespot[12662]: time="2025-10-28T10:58:23Z" level=debug msg="completed challenge" Oct 28 10:58:23 volumio go-librespot[12662]: time="2025-10-28T10:58:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:25 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:25 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 415. Oct 28 10:58:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:26 volumio go-librespot[12670]: go-librespot daemon starting... Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="app state loaded" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=info msg="zeroconf server listening on port 39173" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="obtained new client token: AADY6d889J4yPdZeMsuKN8QsH5jBNEyN3ZIzr2LbqCiE44pXL6SGKRwiBDOUuvToCGRbzTLu2uVNZpQuNf4Iy2zqMGjXS20KY/7Eb/wOuPhbEsVB3qPe/Hecltu6efieUeVsYAswgX+1SC740xbLwDP5f59GF5dUodOAUPIXagZbtcUNS9IfAVRNpudFTkFLXhGnpOJaBMgBOFwTwj9XVw4uZQJjdGpD2xj0WN3i/6QCPW5ZXtca3Zw=" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="completed keyexchange" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=debug msg="completed challenge" Oct 28 10:58:26 volumio go-librespot[12671]: time="2025-10-28T10:58:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:28 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:28 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 416. Oct 28 10:58:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:29 volumio go-librespot[12692]: go-librespot daemon starting... Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="app state loaded" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=info msg="zeroconf server listening on port 36227" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="obtained new client token: AAB5g7GZRNWTv5bfybRUAXXbtcvKrhThz5T8SgudC9d0+NZxZ+YVG6aFvFn2a1mBYkYGazawzyAuaC2AxgXTGXGZKZoiDCXEmGAcDv9YpkkNy0IWuvmB+0qBxHGBfZNhseWOm2owp3++NmmVbdcHjjxWiaSXMY23yoTWXohu2F2Wu2WWifKrkNzvzmk1gwsdO+j0YMebN+7FMKR6x2TeVbqnFGl6CQIBvocvqbYapQZ3mtHn9g12bbY=" Oct 28 10:58:29 volumio go-librespot[12693]: time="2025-10-28T10:58:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:30 volumio go-librespot[12693]: time="2025-10-28T10:58:30Z" level=debug msg="completed keyexchange" Oct 28 10:58:30 volumio go-librespot[12693]: time="2025-10-28T10:58:30Z" level=debug msg="completed challenge" Oct 28 10:58:30 volumio go-librespot[12693]: time="2025-10-28T10:58:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:31 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:31 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 417. Oct 28 10:58:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:33 volumio go-librespot[12700]: go-librespot daemon starting... Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="app state loaded" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58: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-gew4.spotify.com:80]" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=info msg="zeroconf server listening on port 34677" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="obtained new client token: AAA0ns2EIkO2GIfW/djSN9sUFR0rSFnCciXHYpCryCJAQDi6bjfKMbb7Agy/Rk8Tp5loSO5QGIL0S4Zo4IHGGbU7I67f9RoFMee7RYE6dpMyR0wAyquxtNwBluWsR3eDAmbM+MNKl956QoB8r1cUTNco45iJbTUK+OPkbEfEW5cDfACoSScqYNgF7DhwWCCarOuRSXGw7wqzs8LpQQHC4BZy8GNI4IqBDKmq/8x5948frOiWKE64HiY=" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="completed keyexchange" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=debug msg="completed challenge" Oct 28 10:58:33 volumio go-librespot[12701]: time="2025-10-28T10:58:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:34 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:34 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 418. Oct 28 10:58:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:36 volumio go-librespot[12713]: go-librespot daemon starting... Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="app state loaded" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=info msg="zeroconf server listening on port 36049" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="obtained new client token: AADemm/CcsSqUmlYiPlk3U59U3ijg17hvM9jN9x7sPtXM5kgQO4cxvxQzbCq6zXmVqHWO+oB1WOW3VD84xIEQxtbsbJRuHtDtjja5ddpmpimFuoDvy1UWpwurEDVUPm4Aro0oLXrRCSfcLV9Y+EFf1BXMWAlPuZtkw7H0PVL2at1tTMlUu8lAllxvxzbbrc61XwK5rqavIQL+Yj5h4DlV/1nCc7ls61Xs2YyYMaSuobpUa9bu/NdBQY=" Oct 28 10:58:36 volumio go-librespot[12714]: time="2025-10-28T10:58:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:37 volumio go-librespot[12714]: time="2025-10-28T10:58:37Z" level=debug msg="completed keyexchange" Oct 28 10:58:37 volumio go-librespot[12714]: time="2025-10-28T10:58:37Z" level=debug msg="completed challenge" Oct 28 10:58:37 volumio go-librespot[12714]: time="2025-10-28T10:58:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:37 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:37 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 419. Oct 28 10:58:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:40 volumio go-librespot[12735]: go-librespot daemon starting... Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="app state loaded" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=info msg="zeroconf server listening on port 38647" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="obtained new client token: AAD/u7WHaQcA1mA5V5FX684JHfLZlpB7N0ffkA7ixzbXdlC6obH4HzT3fB1690Yx1xBDhLs+uA4HCfVGBDgj+wgXXy4fpdHJ6uBSpUJruORVVMv0Aox8omyhl/cZWF0juHFGc3xhSghUcjZG1wUVSkb7evqs8xQhN4OAgiBBK4AMnkxQhyganKCsv816GYkkXSxGDSFpM1qlupEq0fnq2mHeDN/KEl6E1JTBRLqgf54yu+XgAo7OW6A=" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="completed keyexchange" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=debug msg="completed challenge" Oct 28 10:58:40 volumio go-librespot[12736]: time="2025-10-28T10:58:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:40 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:40 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:43 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:43 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 420. Oct 28 10:58:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:43 volumio go-librespot[12743]: go-librespot daemon starting... Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=debug msg="app state loaded" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58: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]" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58: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]" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58: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]" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=info msg="zeroconf server listening on port 34765" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=debug msg="obtained new client token: AAC1pO23j9btuVFY4pRI8SE+uuku6QvnniOx98vXYDZcYr6OdUMsyXhwwBtWu3K0rAZtqCNeKY/Fy6ruu2QdUsJv8Bz0xMTdA9X8C0PR1bTfrPvBwJxcNX3NheedtvCvGtOO1nBYsPjUHGMBeWrxQRrEmFm73DYF8Jxw3KmeLV9OPUrfGy6d9VsISNoAo0ihrcZceRtMKL9kmWqZgbV4bH7NDE6PD8A6ChVQT5Tp3Sj2sroL1s3ltQM=" Oct 28 10:58:43 volumio go-librespot[12744]: time="2025-10-28T10:58:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:44 volumio go-librespot[12744]: time="2025-10-28T10:58:44Z" level=debug msg="completed keyexchange" Oct 28 10:58:44 volumio go-librespot[12744]: time="2025-10-28T10:58:44Z" level=debug msg="completed challenge" Oct 28 10:58:44 volumio go-librespot[12744]: time="2025-10-28T10:58:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:46 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:46 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 421. Oct 28 10:58:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:47 volumio go-librespot[12751]: go-librespot daemon starting... Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=debug msg="app state loaded" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58: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]" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58: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]" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58: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]" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=info msg="zeroconf server listening on port 43345" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=debug msg="obtained new client token: AADAt1+22kXwIF+i09Sk2VvBqRP92JdqTUI3INd0I90UMtRAwN/D8xRi+HoPtSg1SyK9Pd7Nluvl7iq3Dt4fbE/LPxnpbbwhs7f9ZXMGXsVtEWjL+va6PPhEuJ1BAGFZv4zmAj4R8ixxIKHIiSNm7Nd/3+fHam280c2QKaYfNDhUQzW2ItFN2+dadVJGQlN4v+K9pOc36WOnEHGSWiY75rgTxafC1TBHXlO3InIvtNLgtQmVQ1BNlhQ=" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=debug msg="completed keyexchange" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=debug msg="completed challenge" Oct 28 10:58:47 volumio go-librespot[12752]: time="2025-10-28T10:58:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:49 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:49 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 422. Oct 28 10:58:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:50 volumio go-librespot[12773]: go-librespot daemon starting... Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="app state loaded" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=info msg="zeroconf server listening on port 34369" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="obtained new client token: AAADRJZVIlbUoPLS2TdJ8JfK6pjiiCMCpAM7ztkojize8paKiBdZ1AQrnflbOnwVdeIZGWq4XkElbcFKVvHjKd1s5j268SlUZRf178DMgHNtflspsxqG7V/XWF8KyGmSRuXMC1ymVAYJhxIT87uuXVNaJeZvIAixYSbS516AaulUx3WGNqzISHkgQFxC38eTQP0Kz38oQT1oNgbW0XfBghuVyDcfmIZTfDaNE92bMEGpG5XMkDz8fAI=" Oct 28 10:58:50 volumio go-librespot[12774]: time="2025-10-28T10:58:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:51 volumio go-librespot[12774]: time="2025-10-28T10:58:51Z" level=debug msg="completed keyexchange" Oct 28 10:58:51 volumio go-librespot[12774]: time="2025-10-28T10:58:51Z" level=debug msg="completed challenge" Oct 28 10:58:51 volumio go-librespot[12774]: time="2025-10-28T10:58:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:52 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:52 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 423. Oct 28 10:58:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:54 volumio go-librespot[12782]: go-librespot daemon starting... Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="app state loaded" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=info msg="zeroconf server listening on port 38229" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="obtained new client token: AACYDiLjPP9fGFixgTkeEjnkXTV5wamk78zWDDHnJeA8ncZJkK9HZjIMt9ARgFNThju6YDyqL4BN79jGWEAPW1xwD0weU+P7j8aI86RimWQyasTepvPLPL1geAPlinBh4S9EIBLuZ0mYi7aegkJdUIFn3FKy9d0z4ScJGgMsT/QlvmawXOBIsmg5KalJMcBuTfW5veAyJzgAqIExaL6Gg3CdVWP5XrI6rE5SNjR9XIUNzrFUfWdFbbI=" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="completed keyexchange" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=debug msg="completed challenge" Oct 28 10:58:54 volumio go-librespot[12783]: time="2025-10-28T10:58:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:55 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:55 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:58:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 424. Oct 28 10:58:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:58:57 volumio go-librespot[12793]: go-librespot daemon starting... Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=debug msg="app state loaded" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=info msg="zeroconf server listening on port 46527" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=debug msg="obtained new client token: AADDENoHk/Pkh8qQEgZmd9NyaFxvEvSBTF40a6M4M+oAeeWUYW9NOd/oy6g20/nDJlaNkIPS9lk5zgg4j+SnBU6+XwaOjPYrepScEyZ/SWVEav/9y7mZPaXthJ6L6uvK53ipwtKIQuUli/Oo+0TO04hADWTeNyrxFkCZtFMBJAJDPLeA2LOU04v2GxXAQpimcaGvtiRUOvnXaykBpCyySM4Sa21m7tPY2M+INwswgO4/65TSiZJu8Rk=" Oct 28 10:58:57 volumio go-librespot[12794]: time="2025-10-28T10:58:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:58:58 volumio go-librespot[12794]: time="2025-10-28T10:58:58Z" level=debug msg="completed keyexchange" Oct 28 10:58:58 volumio go-librespot[12794]: time="2025-10-28T10:58:58Z" level=debug msg="completed challenge" Oct 28 10:58:58 volumio go-librespot[12794]: time="2025-10-28T10:58:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:58:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:58:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:58:58 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:58:58 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 425. Oct 28 10:59:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:01 volumio go-librespot[12815]: go-librespot daemon starting... Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="app state loaded" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=info msg="zeroconf server listening on port 44887" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="obtained new client token: AAC2kjCwGv7Vsiq5r+I5nFOrWzEfR/WTR6CoJVsI4mSPg35QXodhICma7Rr15Ttdr3gLj+GcctYDG9YVuIwz6kMFn0kQ4ge8oTuCDC2ObF73SQQp/mIsEY3SR6TWZaB/cXkqXmk3nVSBk5U14+VOz3VIWEaFQpCPVeYyLFjOIujm0aBtIdUldDtqkWhO0AJrkBOqjFawRhllBozz0TymsQRVHeL9zJPevdBGs6NbYPuPTQWjdxW4kJw=" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="completed keyexchange" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=debug msg="completed challenge" Oct 28 10:59:01 volumio go-librespot[12816]: time="2025-10-28T10:59:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:01 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:01 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 426. Oct 28 10:59:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:04 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:04 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:04 volumio go-librespot[12824]: go-librespot daemon starting... Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=debug msg="app state loaded" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59: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]" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59: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]" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59: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]" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=info msg="zeroconf server listening on port 44951" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=debug msg="obtained new client token: AAB70kXX1aDkQIs3eq4nP0WiwOjxy3vMt05pey6pYnVTLPLwRm56KOkSgJ+kiBynj/CYiz2xwYTy8nAbGxIJsMhULCSKV12fqo2cgrCBAvdU45FleEYHUnPFg+G4d9ih2hGYKj4S+emABRYad9qs3Pv20D6g02TkwgazOAMlNVYHrvHWbSPoIAPw3TLV5oPB3BcbbmltZhRh3CRYhWNtaD45kr1U3AKXhLFV4oVao6E27seDzl5nsJc=" Oct 28 10:59:04 volumio go-librespot[12825]: time="2025-10-28T10:59:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:05 volumio go-librespot[12825]: time="2025-10-28T10:59:05Z" level=debug msg="completed keyexchange" Oct 28 10:59:05 volumio go-librespot[12825]: time="2025-10-28T10:59:05Z" level=debug msg="completed challenge" Oct 28 10:59:05 volumio go-librespot[12825]: time="2025-10-28T10:59:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:07 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:07 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 427. Oct 28 10:59:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:08 volumio go-librespot[12832]: go-librespot daemon starting... Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=debug msg="app state loaded" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59: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-gae2.spotify.com:80]" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=info msg="zeroconf server listening on port 42383" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=debug msg="obtained new client token: AACuhL0xBDd+oahlbFIY0QN0bVeXH4eI0/0fl7LBNv1xHzLkLi/l0/8R5QLCuh8LJCIH2o0Tuf1zNctkCmagwqcOQk/Y79CqJvQrKTTLej20XqNke9rpEQvEDbcbZ+uF2k2xZZpclH6VPRusy2XM8GsaLEUfLjeaTq57lrro8g/BLPyGcvMEozpcP3DxT2Hu2e/6jrcI8KkurAY86Lb9Lc/lrp8l9H+HWPe0qxuog/Igwn/lBthXViE=" Oct 28 10:59:08 volumio go-librespot[12833]: time="2025-10-28T10:59:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:09 volumio go-librespot[12833]: time="2025-10-28T10:59:09Z" level=debug msg="completed keyexchange" Oct 28 10:59:09 volumio go-librespot[12833]: time="2025-10-28T10:59:09Z" level=debug msg="completed challenge" Oct 28 10:59:09 volumio go-librespot[12833]: time="2025-10-28T10:59:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:10 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:10 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 428. Oct 28 10:59:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:12 volumio go-librespot[12854]: go-librespot daemon starting... Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="app state loaded" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=info msg="zeroconf server listening on port 34791" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="obtained new client token: AADt3AWAIcDGgIHXxOX1gcG5varYB20Rr0LMOCBNo8ObDaRK1Ik0s8MBGiSBT55X1YqWK2DO4cDlsZKVbDxdxstabX49bBsaDO6ODjZ+16P2y9noNcabzo6p1XfUJ9cm1LXAMWdunPyavreuybnpDoOzvBmhNsklG807gJPWznAEEez1rzC0jM4RA0FR8xU5noGHeq/6MX/x2p81BPbJ42MaW+kCUWRSEm5DLzycFm+AgSB9eS7fYIo=" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="completed keyexchange" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=debug msg="completed challenge" Oct 28 10:59:12 volumio go-librespot[12855]: time="2025-10-28T10:59:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:13 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:13 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 429. Oct 28 10:59:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:15 volumio go-librespot[12865]: go-librespot daemon starting... Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=debug msg="app state loaded" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=info msg="zeroconf server listening on port 36083" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=debug msg="obtained new client token: AAAV5UOiZ6ACjf+gCqQS2nCxigzWLR/luhFYMekLZYO/ZyZo4ytEzVzqhfjU/tph9l/TSPPmV4fm6pHrqmkL6UCAEn98d+/NL49zmFdNSr5neTqIKkNYol983v96/Uw4ZlQGrlaHezivnOQD2Gj+6wf3yfAnk6TlHJOaIQy7texflyhpsoI0xRr1LkCX30VnrsiGq7HNu8tpXIdNuCCLQ1qpHuZm/MnhHfrKSd+t5l1PJrpY0sESU00=" Oct 28 10:59:15 volumio go-librespot[12866]: time="2025-10-28T10:59:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:16 volumio go-librespot[12866]: time="2025-10-28T10:59:16Z" level=debug msg="completed keyexchange" Oct 28 10:59:16 volumio go-librespot[12866]: time="2025-10-28T10:59:16Z" level=debug msg="completed challenge" Oct 28 10:59:16 volumio go-librespot[12866]: time="2025-10-28T10:59:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:16 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:16 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 430. Oct 28 10:59:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:19 volumio go-librespot[12888]: go-librespot daemon starting... Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="app state loaded" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=info msg="zeroconf server listening on port 43989" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="obtained new client token: AACJvSdz+gP66fOUgYplLwGZDNuZ9iovGk2r0NECjXWuBGN+xqmJj+3v/r4wX90adD3v6PKzdUWh8YlMwzZMfpvl1dQHi8gURcnLde2xyzntGYeGxY7jCKpdTYUxoerfCBUpAWk6Ci1kIEUkoB5/bwwSdU+3ydo/tjWcOtbKpaCDwYDrvvhWcuTjNaanRKnXqCVhLkjidUb+faAikZ2UDm3LlQIRfFxEaroZY0HrbAd/HaGZaXe0ejU=" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="completed keyexchange" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=debug msg="completed challenge" Oct 28 10:59:19 volumio go-librespot[12889]: time="2025-10-28T10:59:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:19 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:19 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 431. Oct 28 10:59:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:22 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:22 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:22 volumio go-librespot[12896]: go-librespot daemon starting... Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=debug msg="app state loaded" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=info msg="zeroconf server listening on port 44679" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=debug msg="obtained new client token: AADI5bTZGc6k+dBGICc9toyJzrHhZQsXEOO8cQfzbCzhx6FOFS4dLRg1JN+RoJZrpDNMv7qmilv6JglkEqC/2iUiWsay6xVpGAMG9f4uytW5vfahsD9UZXeji9KFc05NMPngHt7lFOlbD4JgOf+4acylYkQ1Kjf7hJDwR0D3hLRW9SMEiQgeFO2ZBgtvYeJVVUuDXh54WXVih9lbYJkRSiqSZCtecivS+lYhd+Yq/qKfHu5qwUD4HtM=" Oct 28 10:59:22 volumio go-librespot[12897]: time="2025-10-28T10:59:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:23 volumio go-librespot[12897]: time="2025-10-28T10:59:23Z" level=debug msg="completed keyexchange" Oct 28 10:59:23 volumio go-librespot[12897]: time="2025-10-28T10:59:23Z" level=debug msg="completed challenge" Oct 28 10:59:23 volumio go-librespot[12897]: time="2025-10-28T10:59:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:25 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:25 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 432. Oct 28 10:59:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:26 volumio go-librespot[12904]: go-librespot daemon starting... Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="app state loaded" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=info msg="zeroconf server listening on port 38439" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="obtained new client token: AAC2tmA+5aqj0cCOHVBC87J0wd85l0XNDB/uLk0KKAgL8+PFgqqc143Xme7u9bshUO0MPaY+2COHC5UT2gkvGKULAkq8tgQBDe8hoqKsrFI6KeH1whpmalmwv2mPIqW/evhCGT2IXWSl9j+M+1p78btX/y0peEyK6gQetAnKGhKbC/La1sEaVsUy7ZNvFkI805wuAz0oSh+6IqUufhGyRfnaP46Aw7UsF+/r0RNFccJzHjun+x2kUEk=" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="completed keyexchange" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=debug msg="completed challenge" Oct 28 10:59:26 volumio go-librespot[12905]: time="2025-10-28T10:59:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:28 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:28 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 433. Oct 28 10:59:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:29 volumio go-librespot[12926]: go-librespot daemon starting... Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=debug msg="app state loaded" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59: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]" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59: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]" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59: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]" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=info msg="zeroconf server listening on port 45135" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=debug msg="obtained new client token: AADqapJpoGhhGwS+Mc9I4FSbhD9N7BjcC3hD+DllA/EHJs0oGGWzrIxc+Bj/2uxD6zwlI9+TKnqblXpXSOlg/of/bdzlo1ofpfPMwZki3NsdV4N64KmDkn8cQJl675fWAqFIovOcEk2H4QwB/ro3LOMMj2+R0udVffNVMn3QyqTSEc7ACb7bvP4zmfO12BLsn1DBFHuGqexKlrTGrRqbFV//maq8mJNMMkb5ND6Irwf6gE0jEDMdht8=" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=debug msg="completed keyexchange" Oct 28 10:59:29 volumio go-librespot[12927]: time="2025-10-28T10:59:29Z" level=debug msg="completed challenge" Oct 28 10:59:30 volumio go-librespot[12927]: time="2025-10-28T10:59:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:31 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:31 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 434. Oct 28 10:59:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:33 volumio go-librespot[12934]: go-librespot daemon starting... Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="app state loaded" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59: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-gew4.spotify.com:80]" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=info msg="zeroconf server listening on port 40367" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="obtained new client token: AAAF9tHBuYqZd2N+zAM6cdgzRTLSpV//9+Gpr/RavCzdnuWFCponBPnOa6I+2kO1HogoxU55FtlMfw9Xn9KrlcSoZ6jQ4t9PbmrBoQ/narFsyBBfzkGqH2e9YrvainxGqzhmRZzplh7kX3ac0QUniEYC+QAfcAhGIj9Jh5uAnli9AHPcYCQtnTrinFvwebHqfBZHiUua4F8QTIaynrWiih14jbzyvm4jXbuQH0KlwmGGZsxBLWeaAa8=" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="completed keyexchange" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=debug msg="completed challenge" Oct 28 10:59:33 volumio go-librespot[12935]: time="2025-10-28T10:59:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:34 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:34 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 435. Oct 28 10:59:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:36 volumio go-librespot[12946]: go-librespot daemon starting... Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=debug msg="app state loaded" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=info msg="zeroconf server listening on port 46395" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=debug msg="obtained new client token: AABNucUMYW8FaS3hZJuCqFjViu9iAh8+PWQ2iYCEDNsIRHs1tvb8e6b/6ue7eWVOMgJ5f7rIl26cHKLI1RGO0g8F1+FJCWgDoYtl6Jy6AeoZeOG1GvqGsTHx/C3FuAFA/A7RnigEAwufamEWG2HgibG21G6n4gs1baCQ/0vyyVjxILjktqdmofEOMBTS/T2Sa5ShpY9E0Z7gDb5564Hn88v+kFBFy0bk0qP3UD3VSx1CWKUBVP0EJH4=" Oct 28 10:59:36 volumio go-librespot[12947]: time="2025-10-28T10:59:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:37 volumio go-librespot[12947]: time="2025-10-28T10:59:37Z" level=debug msg="completed keyexchange" Oct 28 10:59:37 volumio go-librespot[12947]: time="2025-10-28T10:59:37Z" level=debug msg="completed challenge" Oct 28 10:59:37 volumio go-librespot[12947]: time="2025-10-28T10:59:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:37 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 28 10:59:37 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 28 10:59:37 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 28 10:59:37 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:37 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 436. Oct 28 10:59:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:40 volumio go-librespot[12994]: go-librespot daemon starting... Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=debug msg="app state loaded" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59: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]" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59: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]" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59: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]" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=info msg="zeroconf server listening on port 45307" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=debug msg="obtained new client token: AADFIBEzNhbf+BjoxTGnpEdV6VL0Yy7WBQl4HKRCYzqBrgv8iHwqDfYIvdp2fY86xhnDoBxl50puWQ6nl64GA3u0sAWNstWkcrnLiQ3EwaIB1vSuDFnkFw0XooT3g/Wn58V2OEYgXiCKDeVoJK+ZL9YyVE95FRgC+r930v3Nf3ErvOY0jM5sD9UabqUROFkTCSsqjqibGyW3pYqLbl47swVMRSeWYG+EJb3Bt9u8BXFRuIPrlk3bgVk=" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=debug msg="completed keyexchange" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=debug msg="completed challenge" Oct 28 10:59:40 volumio go-librespot[12995]: time="2025-10-28T10:59:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:40 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:40 volumio volumio[11683]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 437. Oct 28 10:59:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 10:59:43 volumio go-librespot[13002]: go-librespot daemon starting... Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=info msg="running go-librespot 0.4.0" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=debug msg="app state loaded" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 10:59:43 volumio volumio[11683]: info: Initializing connection to go-librespot Websocket Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=debug msg="new websocket client" Oct 28 10:59:43 volumio volumio[11683]: info: Connection to go-librespot Websocket established Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59: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]" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59: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]" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59: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]" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=info msg="zeroconf server listening on port 45505" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=debug msg="obtained new client token: AAAUK5Zw1tc0grFHVQtBjEjbnDbfJ9EMwkNaUCH94vc6guo5eyhJN7d4gVwNcSgAGdr1no8l94V2jfIhXwlPrvjTaDdaTXWDfjnOv/RIAVKNf9XbiVqebxrdgmubtzTtkajoBypZhcaTEZp5cxAC5Sa+VfuMC3O1uZD0ebnWMvjmMorjayyrzPfT4qKK+9+LNVtmjPkLhHVhSafRdVuFT5kXAZf1U74xeCVjWyg5ORxjNA2qDAXfLvs=" Oct 28 10:59:43 volumio go-librespot[13003]: time="2025-10-28T10:59:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 10:59:44 volumio go-librespot[13003]: time="2025-10-28T10:59:44Z" level=debug msg="completed keyexchange" Oct 28 10:59:44 volumio go-librespot[13003]: time="2025-10-28T10:59:44Z" level=debug msg="completed challenge" Oct 28 10:59:44 volumio go-librespot[13003]: time="2025-10-28T10:59:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 10:59:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 10:59:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 10:59:44 volumio volumio[11683]: info: Connection to go-librespot Websocket closed Oct 28 10:59:46 volumio volumio[11683]: info: Getting Spotify volume Oct 28 10:59:46 volumio volumio[11683]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 10:59:46 volumio volumio[11683]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 10:59:46 volumio volumio[11683]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 28 10:59:46 volumio volumio[11683]: errno: -111, Oct 28 10:59:46 volumio volumio[11683]: code: 'ECONNREFUSED', Oct 28 10:59:46 volumio volumio[11683]: syscall: 'connect', Oct 28 10:59:46 volumio volumio[11683]: address: '127.0.0.1', Oct 28 10:59:46 volumio volumio[11683]: port: 9879, Oct 28 10:59:46 volumio volumio[11683]: response: undefined Oct 28 10:59:46 volumio volumio[11683]: } Oct 28 10:59:46 volumio volumio[11683]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 10:59:46 volumio sudo[13024]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-28 10:58' Oct 28 10:59:46 volumio sudo[13024]: 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"