Nov 02 23:58:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Nov 02 23:58:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:00 volumio go-librespot[22173]: go-librespot daemon starting... Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="app state loaded" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=info msg="zeroconf server listening on port 46411" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="obtained new client token: AADPzxr0PMRx1KFViTKEOkRrTntiJvKnnxOMdIBRkntnie6eEu7rgrRcoVA83JPsgO1hEQdr9NP6g7VUR3Zn0gDEmN9VpB+EW6tIDj8hsFs0PqPUmsw285vJC7wpYoOuhnjWE1hChvWzO4JzGSzUtX2WkcTzbDkY4r9TY3DfhB5jDbUwiFXBBCPBE2bAaw8DvKii9ydsqLehVOBy/c8oYjkvr8VVXmvY3SpPBoXyQQYYz6hMzgzVmME=" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="completed keyexchange" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=debug msg="completed challenge" Nov 02 23:58:00 volumio go-librespot[22174]: time="2025-11-02T23:58:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:02 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:02 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Nov 02 23:58:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:04 volumio go-librespot[22195]: go-librespot daemon starting... Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="app state loaded" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=info msg="zeroconf server listening on port 45423" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="obtained new client token: AAB5pL2hYhQk2074BsGc4KCUILI2NlBd3bwcBMiJVLOMNaT6GNQLjv9u9043YT23qZwqDO3fTHDKYISyFr1GNVy4MfRCzCqbKpd4XXJb7regt2hpZCMfOkMLd41lknLiVvmiLm+fKZolcOwUKgHT80Tl3gOC3o9ISWkHxWE8ilEBsFFIP7p4+P5GVZHHuzJDmt8gGVYG0d/5p5bPmn7NBA0ni8XcN3/m1X2u/4XVPdVVX5HVwFjh" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="completed keyexchange" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=debug msg="completed challenge" Nov 02 23:58:04 volumio go-librespot[22196]: time="2025-11-02T23:58:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:05 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:05 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Nov 02 23:58:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:07 volumio go-librespot[22203]: go-librespot daemon starting... Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="app state loaded" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=info msg="zeroconf server listening on port 36841" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="obtained new client token: AADYHqvXsTussI7W350y9QOdCFy5x9SC1M//knWazdxnNfKwjqQ5XXzfPNsH9yLM7gUfnc2HMJJLHlp5EQNZzmRhkNwOuQ11vjBJ5or7Kp2/jtlpYy/yZjz4Uomvn5sig8YzjvLx9ljE2RIuLTDP/SGkVHDraFXI/2dbOVCazkppt8zW9azjzmhvy5GcU+cN3Cl5zGzIrtX2BnstmVgHjCuvw60MhDPOX8vreoyOV967/jcahk8v1aw=" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="completed keyexchange" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=debug msg="completed challenge" Nov 02 23:58:07 volumio go-librespot[22204]: time="2025-11-02T23:58:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:08 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:08 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Nov 02 23:58:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:11 volumio go-librespot[22215]: go-librespot daemon starting... Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="app state loaded" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=info msg="zeroconf server listening on port 39913" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="obtained new client token: AADGYGREcyJ6lKs1AOyJ1MtA+dOL2D233v6KeCiLkBPhn86DPQ50rjWwn6ZwIFIReYNRTI8Qmu5PgvuGFxbnDx7a7JOBrb6xNYyEZbP3f7yAy8k4FskdN00SkNIX8ZOI3+U8ADck/Crtyn7TZO+h/xwemz29eMRqyqPQJL5PgPyKCg5og51Do+iiA1iSJiSJdtTFDYT8t+pi0laOPaU+nasVRZJjozCm0RO4/Cnd0J89hr1LykHd" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="completed keyexchange" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=debug msg="completed challenge" Nov 02 23:58:11 volumio go-librespot[22216]: time="2025-11-02T23:58:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:11 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:11 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Nov 02 23:58:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:14 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:14 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:14 volumio go-librespot[22237]: go-librespot daemon starting... Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="app state loaded" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=info msg="zeroconf server listening on port 34983" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="obtained new client token: AACkO1KFMkOgcRB7L0zflAQn5FNRNC0mfpcyfDHm2sM00UiLZRYh8oC/jAt+tj034P7Y1o72ysWLdVPH5XidG5NVsQ/Xrtd6yBpYIW15O+E69FwqxV9VKq9Xcs3tuWUpB7rLNxz4U6admPryurCc9NE+Tj8tM1HvyCTYmWQR8e9VLSzFc9/QW0Ql+jitao0taT3UQFHUm90LRcVMyHdcgWJ9s6nqHp7y7vLf5PeJ0XS9FAi7t3HFM0w=" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="completed keyexchange" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=debug msg="completed challenge" Nov 02 23:58:14 volumio go-librespot[22238]: time="2025-11-02T23:58:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:17 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:17 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Nov 02 23:58:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:18 volumio go-librespot[22246]: go-librespot daemon starting... Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="app state loaded" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=info msg="zeroconf server listening on port 33647" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="obtained new client token: AADRcCxOlWJipEnlGRoZrEJ78CqYxKDIG5Exajbd3xXnLWklYA6PHQuG9T6inJ0i6HY4IJ89J76mNDjVSO69ap5ckVhxT2z2jHWWrPf49gDyuv6cviGv55bVz6IyPH0rwM/B9W9QYzTHEzsF2DbfdzmG5ApHersyTzcoLoezCEoxCYh6sV4UXri3Cod0WGOkHlMJ/ftFGPu/hCC8wOCGKzos6itJfeMhltNQsvwx2z2jUitgOhV/" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="completed keyexchange" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=debug msg="completed challenge" Nov 02 23:58:18 volumio go-librespot[22247]: time="2025-11-02T23:58:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:20 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:20 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Nov 02 23:58:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:21 volumio go-librespot[22255]: go-librespot daemon starting... Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="app state loaded" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=info msg="zeroconf server listening on port 35099" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="obtained new client token: AABEXmgfOI2yL4/knQz3ekl2fvDiHfRUrS2QCXVI5cdvblI/8F0hEUV3DDPubAuuhrox0O9ZwHrgNExaMPjhGh1z2akt7Bkipg3B88piIIwVXwEej4BIDCwEJ1Fb5n727fKhsMAxz8rbk9jH3JmFTgDQ1Is3VVfuST1XPDu6WhswFrOaLHEGLAj3hZ8UXfnMZg6mLpMrXKcJcgCbqKWTS6MCVz23YeCEvGJ8zTzaU23TZ4FdviyzSrY=" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="completed keyexchange" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=debug msg="completed challenge" Nov 02 23:58:21 volumio go-librespot[22256]: time="2025-11-02T23:58:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:23 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:23 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Nov 02 23:58:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:25 volumio go-librespot[22277]: go-librespot daemon starting... Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="app state loaded" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=info msg="zeroconf server listening on port 41627" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="obtained new client token: AABbY1xzOOSDYvETmRuUHfqxMTSKKwk3KOlz6LxuSEFNh20y84ZojVkRNf75QRtyEkHVOurem3AP7eZwQHYEp60n7Dlr9futqxD3oVXG/JrycRR3WYPP7cBdxFXLTiRqf82qUwAJ4DDehPZ/U1uFc2/Jn6QvAeMj11cSjXuiydhfs6Nrl7GYIoLC1o0+06hTwPAUDrksGvkHNib3mIlDhhAQre1kh2oIHq3sXsEqStOzGbJpJxmu" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="completed keyexchange" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=debug msg="completed challenge" Nov 02 23:58:25 volumio go-librespot[22278]: time="2025-11-02T23:58:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:26 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:26 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Nov 02 23:58:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:28 volumio go-librespot[22286]: go-librespot daemon starting... Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="app state loaded" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=info msg="zeroconf server listening on port 40665" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="obtained new client token: AABWq996B+W1oK62K6zHS/Ck5E7C1TWFsz7TWEdiz1esR6i3AEdfyBRWEM+8prNOUb9BKZELiffOAHuLgPXBZIHELDAGWr1iTg+i8sy35fpB2oRqEFKXXVYAmG4zINgMVFr8E5in0tfhV9DBbi/yBGoKHpbzPrsjkp2Rgu2tW6VamM1lIr5Jyu/SSVTI4Ty+geNKTtBEsAC+TH4dYODIsr5EwU57d1pO2aBWB+5XR+F1lu3ps7Jt1MI=" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="completed keyexchange" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=debug msg="completed challenge" Nov 02 23:58:28 volumio go-librespot[22287]: time="2025-11-02T23:58:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:29 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:29 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Nov 02 23:58:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:32 volumio go-librespot[22297]: go-librespot daemon starting... Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="app state loaded" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=info msg="zeroconf server listening on port 38759" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="obtained new client token: AACGUGdgh880i9bQRFt+4lHe7ZPL6bg9R3JvvSuGBJG8t+vg36c2rAoNmfjVxrScMm/aU6Cik5pTrYPfzKXXX62357px/ac/cHTUQLi9a+cHNLEfAjC3HYK++4+JJjCxArvtw5Z9esKQ1/W7w4ss6Etq9lJ7mL1v+zMkE4MUOL3hYGK219vvIqRg1pU43QC95VK4fI1qUUP43Ml2hru7lGGmJVJN0nsH3KAVZwauTmVoVjpI9HJy" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="completed keyexchange" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=debug msg="completed challenge" Nov 02 23:58:32 volumio go-librespot[22298]: time="2025-11-02T23:58:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:32 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:32 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Nov 02 23:58:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:35 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:35 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:35 volumio go-librespot[22320]: go-librespot daemon starting... Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="app state loaded" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=info msg="zeroconf server listening on port 36289" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="obtained new client token: AAAfPnDhABiEhH8iON6cQyvk640HuoO7CAb69dR4dX/9nzzJrcyJs2a4k5ZftGv66hz66HF+eD1SeIJvTvKwch8ZkL8YPEmQF4c814fjmTg77wdH9fHDQz+C40456OI5MzYyFf0vGlC28ubmN6oKMaBqnM/a5wKff9mAzo0EtoW2Dvk/dnzl4insRKQMOvngRXs0hKzMAy40PiPkkePvgxaohlM75dE2oa1AOSSWo+FsAqQwh01q2a8=" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="completed keyexchange" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=debug msg="completed challenge" Nov 02 23:58:35 volumio go-librespot[22321]: time="2025-11-02T23:58:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:38 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:38 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Nov 02 23:58:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:39 volumio go-librespot[22328]: go-librespot daemon starting... Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="app state loaded" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=info msg="zeroconf server listening on port 33617" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="obtained new client token: AACe+cDwsXTRxpSXYlR0PDZ946PIPvkuvJfPNoUHaMCdSZ2SBQWeDgqipQI/bokxctlnnkNcmc2bRduE2ivlb/htSPaLn6lXJQWVjSH6OZpTR3aGhW9lgPBVvlTQVwvNkIHY2xODwTPSDRg4YmS6Ge25/fYCgltJpyinaNyIYyw6GVGu0WfmcKwV9DgNW3FzSu/+aBND+2/ar/2Ke97uzj7Rq8bfR7Fv9tEYoKMS2GgPwr70IzHW" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="completed keyexchange" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=debug msg="completed challenge" Nov 02 23:58:39 volumio go-librespot[22329]: time="2025-11-02T23:58:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:41 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:41 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125. Nov 02 23:58:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:42 volumio go-librespot[22336]: go-librespot daemon starting... Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="app state loaded" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=info msg="zeroconf server listening on port 40343" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="obtained new client token: AABERcgl54ykzjNIA5PUJfIALxM+3vqHg3PG4H7dJ64694W7/nZUHEG0eXKpr7XQ/8o6WTMT3sM/WKMgSQFZYLAsGJo3cgLnCaa2BjmsDc3VfNJDeeT8zbG+TUXslHgZesttus3Ga0oIF2Ov/4FP/NmG9htJCh+6nZXWgQuqEmzKrfXlzNMRw50M9oBjWc6TwpPAK5RnFfS+cgnfJkhj68kGv5LcqQZvGQFyE2S+Tvc4OGODcaGs6sc=" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="completed keyexchange" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=debug msg="completed challenge" Nov 02 23:58:42 volumio go-librespot[22337]: time="2025-11-02T23:58:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:44 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:44 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 126. Nov 02 23:58:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:46 volumio go-librespot[22359]: go-librespot daemon starting... Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="app state loaded" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=info msg="zeroconf server listening on port 38479" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="obtained new client token: AADCrCkW30joz/BQLI3wFkZRhoSAQS7pKRISiSoh7q9PFpx6f2lWGKJBsXVf+rAJtoj1AVMfHPWhMmLtXrRz054cme09Iih/vqvOm0CFx1XQOE78e/0eTpKkazemrPdHuaSI6DkMMLLyvTfzb+lz0Qa6vGr9Rxgm6jkngMPirH3LGR/yNALEdDh2EW+RsZ6ZgCH7ounA3H2RArwKZbiQy0xiSwHOORUQxj/+/f45jFI4LVcg349m" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="completed keyexchange" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=debug msg="completed challenge" Nov 02 23:58:46 volumio go-librespot[22360]: time="2025-11-02T23:58:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:47 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:47 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 127. Nov 02 23:58:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:49 volumio go-librespot[22370]: go-librespot daemon starting... Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="app state loaded" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=info msg="zeroconf server listening on port 41349" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="obtained new client token: AACjWRRt3lGa7kEm9MP/Q2BMDKrjuB//fWm3pzXzT0eJSneCapa/ptOwFmKLQLtaV6dOt4gsIskuVrrW8bFNrfDX1A5V8L8LWOFoiRCGZJVNzVLELfsNyqVlG7tCbwqt+ryvzxzn9jMoUad9JnbJ77T+VSMvGOOMmsuFS0ZZawMHJIaEhbAX2zAvtFVihVwXYgsDKu66eF7dyo/legXbLJ7J+XaypHTa1R8eEGG3vtRoT5NSfY0M1yc=" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="completed keyexchange" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=debug msg="completed challenge" Nov 02 23:58:49 volumio go-librespot[22371]: time="2025-11-02T23:58:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:50 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:50 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 128. Nov 02 23:58:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:53 volumio go-librespot[22378]: go-librespot daemon starting... Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="app state loaded" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=info msg="zeroconf server listening on port 39599" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="obtained new client token: AADwfLVhIvX1l9uy33bwX9Z7vQw4F0ZQ3yjw1IhHFyS1w+EG7wqLgi7wyZ+ABb06fzZSIyt8U8+QSzCgfHqomFgFGjD4DVOhC+1Qtj/HvbafroVBC2eCTKipW07lix/MGISn1BvRlERhW+qgV+8yG2eNUS/xJNdfuKclrit2lHw0JXLoHihlxagMGlwkOltdeiVegZW2d3QIVQRk5/9YD6hFcd5UxWYz6khym7JydTkIfdO3M4Ob" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="completed keyexchange" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=debug msg="completed challenge" Nov 02 23:58:53 volumio go-librespot[22379]: time="2025-11-02T23:58:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:53 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:53 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 129. Nov 02 23:58:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:56 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:56 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:58:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:58:56 volumio go-librespot[22400]: go-librespot daemon starting... Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="app state loaded" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=info msg="zeroconf server listening on port 38359" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="obtained new client token: AABGzpDA+wGUPeXrTpvQP/7GKZoCKQ1HV0HaWQCOaXAtW/64Dq8zjUCfRI9r3gE4HR9x9G/BqmlJltEuYeY8PvorOx4KOqG8z9VE+palKZLDj7dFrCh3Wd0WK9CD8l15ubDxIVM+N1GDAwKx/iV+k+UXdyGPh+OxXdpP9CXfq7qO7em9a+V+PtxRe7TH6GLj+duvzCSlbWSOcYF0PQsnmffJjH0/opWuxtYEDoHgRDt5dRjzTowB/eI=" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="completed keyexchange" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=debug msg="completed challenge" Nov 02 23:58:56 volumio go-librespot[22401]: time="2025-11-02T23:58:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:58:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:58:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:58:59 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:58:59 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 130. Nov 02 23:59:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:00 volumio go-librespot[22408]: go-librespot daemon starting... Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="app state loaded" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=info msg="zeroconf server listening on port 43955" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="obtained new client token: AADnLfQ0eSzblgZcu0qOxown0mV/51rqgCQNY45QdRK1aeDoqnv2mkMFxbgER5BV68AJzAD+YoZYhkD5MZ+jabkXcFk7bBUpneLLma/i+IyF3O14GdEF9p9/yjzJhlSIBFVIW8T2GylO/dqNJDyI8ZCBCijmSyMvE8GCAT02adJFfPU3uewxtDIbK7u/jvKx1KVUNn99EkNPOneeRE6+OwUQ2+cvaTC+cJJgK66MO7S9LNhIGdwJ" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="completed keyexchange" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=debug msg="completed challenge" Nov 02 23:59:00 volumio go-librespot[22409]: time="2025-11-02T23:59:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:02 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:02 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 131. Nov 02 23:59:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:03 volumio go-librespot[22417]: go-librespot daemon starting... Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="app state loaded" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=info msg="zeroconf server listening on port 37181" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="obtained new client token: AAA1yOM4eywQ/Ml/VysfJ9uQG2wKNJLGhQ6O6USegzNrP9iBW+rlMlfxTAmhwMNlgP7/HQrKoRj+V2TmdFnJd3AdNjJyj5M5OPVIgqtLcPPRFFpgiPZkDZ877RQbMrjF0gSysNc4yBRAtwvR6lWM9lAYibtMurD+88o/dorMGcuyaA0hG/ItInGK9Q8W2ECQv9Tjv9UFOR6HFB4mWnth7rtrtvq7I+cNi+V8LttV3F/32YTtAq/h3zw=" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="completed keyexchange" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=debug msg="completed challenge" Nov 02 23:59:03 volumio go-librespot[22418]: time="2025-11-02T23:59:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:05 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:05 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 132. Nov 02 23:59:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:07 volumio go-librespot[22440]: go-librespot daemon starting... Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="app state loaded" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=info msg="zeroconf server listening on port 35887" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="obtained new client token: AADQD4BZ9inZ8UW8kZwZpN74hcmpnamJiOZ/xLG6d6eSeDrX5vlrV0mCpPXBXDFH9/RgByrsurmff1r/FF2IRxRgaMGcICu9A9km8p2LNY8qLyxhJmz2jFRdpq7xE+EQ3e8LdIbivRVh1ZC/2U/Lqw+LOEMaEPtjqtF+ef1LsUgbgTJDnFkQEMd4WyHuu64Lrpz6lx7ITmkG/WY6P8u/aN1Q2yBh1skXr0+utPU7tzX0tOrkG0Dg" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="completed keyexchange" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=debug msg="completed challenge" Nov 02 23:59:07 volumio go-librespot[22441]: time="2025-11-02T23:59:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:08 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:08 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 133. Nov 02 23:59:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:10 volumio go-librespot[22451]: go-librespot daemon starting... Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="app state loaded" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=info msg="zeroconf server listening on port 38979" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="obtained new client token: AADjX4XzRHdQ30MyreZInwJtoQCzSbLjFQ/Psf6FftixQQ3tBuPTxcHNDlIa/gdCUAl9qsz9WKcsrjsjoKoyOENxMNGo47PgN3Oze1Fn57wODYU//qxaXwpuqUWWKJYsy64Hzy+PLKQLCHlWSYrWwvKpaqE51JePJBDzypzx1ZUzuUPicAO7197kmjHeYP0lUb5quD7TFLqBmf2D14xNx7dIOEcq2wDVFb4/rHc22aazlJykaVpPnAQ=" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="completed keyexchange" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=debug msg="completed challenge" Nov 02 23:59:10 volumio go-librespot[22452]: time="2025-11-02T23:59:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:11 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:11 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 134. Nov 02 23:59:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:14 volumio go-librespot[22473]: go-librespot daemon starting... Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="app state loaded" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=info msg="zeroconf server listening on port 39199" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="obtained new client token: AAA2uOOWO+EwJp0GMMtHKHg/0uw1oTARMDAS1sAbs9RKN/FqBVnUzp9hD9kXcWbGSx35pG2vooDk18KJh4XmueLu1YEp6irpqlgNjODqj1KT6dr2jUc6NxZKwrm6Ctj/mDwgZCRWcc6FLakmhuynxmgq2rPetG42V7sMTimi8QsBZx6gaSuprh9umtHeNFzJtNLV0B4Sgy9hDfSNkLKJDUREy6DWpurjTTs3qV7sGzQ9R4zwEQcm" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="completed keyexchange" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=debug msg="completed challenge" Nov 02 23:59:14 volumio go-librespot[22474]: time="2025-11-02T23:59:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:14 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:14 volumio volumio[21492]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 135. Nov 02 23:59:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 23:59:17 volumio go-librespot[22481]: go-librespot daemon starting... Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=info msg="running go-librespot 0.4.0" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="app state loaded" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 23:59:17 volumio volumio[21492]: info: Initializing connection to go-librespot Websocket Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="new websocket client" Nov 02 23:59:17 volumio volumio[21492]: info: Connection to go-librespot Websocket established Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=info msg="zeroconf server listening on port 35305" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="obtained new client token: AAA7o5fUdDT+DoczK0f/lBcDQJl97c2BjsWaRezIndyqoJzxyEMzlrtojfOFD25E4UQ8QKWH09JpkTLq3ITaqtWoWZRr77y+nnZ+8fQrj8opKzDBHssppQfKRi8ofy3PyWmHrQj0F+hxotGc1ukcVOnJi6LoVe+jIyHJ3N1ibx80UDGRv2FY87Ccm6Ukwig+4f2z5zpwclPSPQywzf7PlssZ1CHx6ayp76HrvY6Lt0UukmaUIKw5BgA=" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="completed keyexchange" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=debug msg="completed challenge" Nov 02 23:59:17 volumio go-librespot[22482]: time="2025-11-02T23:59:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 23:59:17 volumio volumio[21492]: info: Connection to go-librespot Websocket closed Nov 02 23:59:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 23:59:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 23:59:20 volumio volumio[21492]: info: Getting Spotify volume Nov 02 23:59:20 volumio volumio[21492]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 23:59:20 volumio volumio[21492]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 23:59:20 volumio volumio[21492]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 02 23:59:20 volumio volumio[21492]: errno: -111, Nov 02 23:59:20 volumio volumio[21492]: code: 'ECONNREFUSED', Nov 02 23:59:20 volumio volumio[21492]: syscall: 'connect', Nov 02 23:59:20 volumio volumio[21492]: address: '127.0.0.1', Nov 02 23:59:20 volumio volumio[21492]: port: 9879, Nov 02 23:59:20 volumio volumio[21492]: response: undefined Nov 02 23:59:20 volumio volumio[21492]: } Nov 02 23:59:20 volumio volumio[21492]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 23:59:20 volumio sudo[22504]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-02 23:58' Nov 02 23:59:20 volumio sudo[22504]: 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"