Oct 31 12:38:00 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:00 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Oct 31 12:38:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:00 volumio go-librespot[11590]: go-librespot daemon starting... Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=debug msg="app state loaded" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38: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-gew4.spotify.com:80]" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" 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 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" 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 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=info msg="zeroconf server listening on port 38367" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=debug msg="obtained new client token: AADNQAH3QCqHs8QlBwJ3ZwyQLw2k/CPyVjtZXBe/NtwpmWoe4LRFElwW75kxQGtJR8neldcMe2xben/owPCPvtNzMxb7qpBN9kLRFZDFXadguxW+u2+0kyGwmjdk7LqmqcG3NHlExJ0FlCB0LTGOnAh7RuVau2kyT4Dv8dzYJoy3KaJjzs0n391wDw2Gv63IoZgCqpknDVTkRkpxsaAnCEtW+cc+rRxJrZrB/ztgWCOzOTsQ5kXqLgs=" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=debug msg="completed keyexchange" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=debug msg="completed challenge" Oct 31 12:38:00 volumio go-librespot[11591]: time="2025-10-31T12:38:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:03 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:03 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Oct 31 12:38:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:03 volumio go-librespot[11598]: go-librespot daemon starting... Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=debug msg="app state loaded" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38: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]" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38: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]" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38: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]" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=info msg="zeroconf server listening on port 34195" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=debug msg="obtained new client token: AAD5yb3bHUDUcMNXxMWR/yC+reSy/7Wy5lpYbIeQwMJUcXa/visJ70x0RJaeQQDmWqTaHYw70nf8k6A23w6jz3Bpegs4fao+qKVoYxXa7AWYeA3/sdEAguYKu79pJAYBuy0QE5NVh0ilxOO5TS10tztG1pltS0/z3+aujaVFUxacFTLZ5NIThNSPD5j8Wf1SB+0HMKM6VZonpEE0LWp7kC9AIApm2k6p6WMgllgJwFhG4NMBGQ1aFrc=" Oct 31 12:38:03 volumio go-librespot[11599]: time="2025-10-31T12:38:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:04 volumio go-librespot[11599]: time="2025-10-31T12:38:04Z" level=debug msg="completed keyexchange" Oct 31 12:38:04 volumio go-librespot[11599]: time="2025-10-31T12:38:04Z" level=debug msg="completed challenge" Oct 31 12:38:04 volumio go-librespot[11599]: time="2025-10-31T12:38:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:06 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:06 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Oct 31 12:38:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:07 volumio go-librespot[11607]: go-librespot daemon starting... Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=debug msg="app state loaded" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" 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 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" 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 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=info msg="zeroconf server listening on port 41965" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=debug msg="obtained new client token: AAAPY8z9NWIneqv9JXJ3zL8z6rfknKgf5m7Kc6YovmnR/fhVy84cTpoqj7ofd0p5xT2MTFeQASLQR5T6plj2mN1O/70m1XWacBydlm5s7GpRkx8t1HrGjtnf2RMQgqOA+Il2MIo4G2cFkWcj/RmwdphKfmunSrke9yME+pmUjA7ury3iwl1rEr82ISorJlgt5FNz7MOya1Ixgn3WvtnRQR0LL5sDFSl19cwBS05xd32Igr1Ev18b2Fg=" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=debug msg="completed keyexchange" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=debug msg="completed challenge" Oct 31 12:38:07 volumio go-librespot[11608]: time="2025-10-31T12:38:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:09 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:09 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Oct 31 12:38:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:10 volumio go-librespot[11629]: go-librespot daemon starting... Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38:10Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38:10Z" level=debug msg="app state loaded" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38:10Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38: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]" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38: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]" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38: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]" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38:10Z" level=info msg="zeroconf server listening on port 43325" Oct 31 12:38:10 volumio go-librespot[11630]: time="2025-10-31T12:38:10Z" level=debug msg="obtained new client token: AAAFMDfdD8G9OMc69LZ0yz6hp9ghzrI5N3BKXFT331uZgIcpCeGQweVv+W3Eg0Ch722EjVkBqlJpOwi0WRC4Tkji9nNJ6at3BQQGWRprGuYxNSltBU5V4x+GxVkaLYPQGsAj1jtoHWq30GxYJtfKaXgOYMKwbrQLkmNlGpnfwbjOqFxWit/4orCLVypBF195Zz97r72gkbLOUAHel/Y2qfqcCSl3bGIT7k9YCXJ7+qeRzWZcUcbOKqI=" Oct 31 12:38:11 volumio go-librespot[11630]: time="2025-10-31T12:38:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:11 volumio go-librespot[11630]: time="2025-10-31T12:38:11Z" level=debug msg="completed keyexchange" Oct 31 12:38:11 volumio go-librespot[11630]: time="2025-10-31T12:38:11Z" level=debug msg="completed challenge" Oct 31 12:38:11 volumio go-librespot[11630]: time="2025-10-31T12:38:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:12 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:12 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Oct 31 12:38:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:14 volumio go-librespot[11637]: go-librespot daemon starting... Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=debug msg="app state loaded" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" 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 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" 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 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=info msg="zeroconf server listening on port 40783" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=debug msg="obtained new client token: AABmxDp/vBJlzFnI05iIygX+L4yGfTq+YyHnGauFY8yMMdQjtEFd9e1wbb4PR8HsqoAvekqegNzV4wzJCrP1rZRMSETH9tCk6YL3b17Cy83oUPT/Ag775i979m23yaMaIhMjiN6m5zc48sVT5K4of5cIw7FjBS3gnxuuQbEo1fqfy2IaAz5SN5neiPkij+G1gQ8IwGyn+ht7cVW7Bb5SUN17QBO2D7o90WeSm4Xc+DDizW5PC0K4OWw=" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=debug msg="completed keyexchange" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=debug msg="completed challenge" Oct 31 12:38:14 volumio go-librespot[11638]: time="2025-10-31T12:38:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:15 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:15 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Oct 31 12:38:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:17 volumio go-librespot[11648]: go-librespot daemon starting... Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=debug msg="app state loaded" Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" 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 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" 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 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" 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 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=info msg="zeroconf server listening on port 46285" Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=debug msg="obtained new client token: AABTLZuEpQhGGKAzRjJU/LPt55v5qtKN9sKEbllyL3CWy2m/t0PO1RqYJeMbqIyc6doykT/SOhtCndEVOzJX0Hf3xs5AfpGV/pcfIxwRipi+HXXrmNL+N/dwdY2rP5h0DcC7Vg/6JATFm7XKzfwLGCgOS0gQ+JZ1HuEON5Gyf3wTcvGSYvbkQCQ/3QjrIM06iB0W4JIlm99avpwL5iANgzx5Z/EVIMQ08YRnsFJJzxUmupeIJT/Ma/A=" Oct 31 12:38:17 volumio go-librespot[11649]: time="2025-10-31T12:38:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:18 volumio go-librespot[11649]: time="2025-10-31T12:38:18Z" level=debug msg="completed keyexchange" Oct 31 12:38:18 volumio go-librespot[11649]: time="2025-10-31T12:38:18Z" level=debug msg="completed challenge" Oct 31 12:38:18 volumio go-librespot[11649]: time="2025-10-31T12:38:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:18 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:18 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:21 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:21 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Oct 31 12:38:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:21 volumio go-librespot[11670]: go-librespot daemon starting... Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=debug msg="app state loaded" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" 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 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" 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 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=info msg="zeroconf server listening on port 44971" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=debug msg="obtained new client token: AAB32VzwY2h8vk51VqClF424dTUkY54mpifzZ30eE7l6kPkWbCicr7qwTsid65Xy7O652zL3SZD67nI43+1m8SsJauafuN4vKRVQiz61DjAEarEcRu1aU70S6KtH9IV9xJkN7BshVWggt0I6YDsr8THjyrdNhF7BGz84EA+59EgkBpjz0tuYU9muo/MwUk5P5lydh0pnXgzYys4UhkKKOBOnQNoAjOgKyFF7RLWsP1aQyX3CiwG/mXg=" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=debug msg="completed keyexchange" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=debug msg="completed challenge" Oct 31 12:38:21 volumio go-librespot[11671]: time="2025-10-31T12:38:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:24 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:24 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Oct 31 12:38:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:24 volumio go-librespot[11679]: go-librespot daemon starting... Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=debug msg="app state loaded" Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" 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 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" 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 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" 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 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=info msg="zeroconf server listening on port 32941" Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=debug msg="obtained new client token: AACkZkPIMkMwUplUpFQSN6xcPUEKzxw4fsDYECxIaLErGU3caoaciqcfJF5CyplZuCpOQ5Hhi6zRDUiYmlHuZAXK0GYUaN5z7PlifJ/YvwzwRY6rHr+kgokIAq/ydzwP/PAocoIaHcscMhuwx/WYRqIRa0zN3CD9PVSttsm+Wu7MyppDL664cbAcwQOww5w4xr191CNXAz1txt/5FwA+z6CTBDMI3XKxLDq1dt+b7iJvJK0M3HDBxG8=" Oct 31 12:38:24 volumio go-librespot[11680]: time="2025-10-31T12:38:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:25 volumio go-librespot[11680]: time="2025-10-31T12:38:25Z" level=debug msg="completed keyexchange" Oct 31 12:38:25 volumio go-librespot[11680]: time="2025-10-31T12:38:25Z" level=debug msg="completed challenge" Oct 31 12:38:25 volumio go-librespot[11680]: time="2025-10-31T12:38:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:27 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:27 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90. Oct 31 12:38:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:28 volumio go-librespot[11687]: go-librespot daemon starting... Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=debug msg="app state loaded" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" 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 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" 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 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" 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 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=info msg="zeroconf server listening on port 44697" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=debug msg="obtained new client token: AAD+QJ+YFPFC+sFVYgP40FfZduPFm3r72P98ApZuLqd59PUvruR+diUXx6jV8rapXB5K1gxPUt1s15NeCOFc9NPQXklayJg7XycSgbgjhZVccT1ppOznZBtTQEz1aD2JL057JXnpZsxzNoMdl+qyUJQ7j1kYVCgFRsILr29ijT5LEbT9xkWcHL+MkVGLTY5M6g468hMbSlD/GBF4mGFyXjt162K8vRupUJA9CO9GIo7gqZi4KGUAyw8=" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=debug msg="completed keyexchange" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=debug msg="completed challenge" Oct 31 12:38:28 volumio go-librespot[11689]: time="2025-10-31T12:38:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:30 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:30 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91. Oct 31 12:38:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:31 volumio go-librespot[11710]: go-librespot daemon starting... Oct 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" level=debug msg="app state loaded" Oct 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" 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 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" 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 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" 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 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" level=info msg="zeroconf server listening on port 45273" Oct 31 12:38:31 volumio go-librespot[11711]: time="2025-10-31T12:38:31Z" level=debug msg="obtained new client token: AABTRjONGx8fpJDifOtuoxvW541tPxDY+NCA4PPn+hYL4prFNcuM17fB6tNBHp5SHXOAxVZdsMl2Lbr7TQqtHjjnnn+E0N9XMN7yy+fEDMkk6r7ajLl5JviIC/bYrP8BDAdB4tyz+wVPdA0qMNxfpww2vQ1T8bcmT2Tu4eu2B+pHS0FWMUIXOzUDtT/7urFt0g0Chr58P1uFDBYahgeNvSEoHVbMstfMVgKsb3Zax87WrfsTrcMqRSE=" Oct 31 12:38:32 volumio go-librespot[11711]: time="2025-10-31T12:38:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:32 volumio go-librespot[11711]: time="2025-10-31T12:38:32Z" level=debug msg="completed keyexchange" Oct 31 12:38:32 volumio go-librespot[11711]: time="2025-10-31T12:38:32Z" level=debug msg="completed challenge" Oct 31 12:38:32 volumio go-librespot[11711]: time="2025-10-31T12:38:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:33 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:33 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92. Oct 31 12:38:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:35 volumio go-librespot[11721]: go-librespot daemon starting... Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=debug msg="app state loaded" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38: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]" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38: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]" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38: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]" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=info msg="zeroconf server listening on port 39385" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=debug msg="obtained new client token: AAAJ5doCi/PjhKOtsQmfiqlB3QoDnVIwcSEFT7QglzmMTvcoRQMyVEkAguqFzpBWFWwu3kW3q13dO7k6rlHmkU8JFnrsg86itz8Drb76xaNBkdyFhLyMv3n4AZiGnqsRtlxxYM7ojZPfYDBtyEBmBDe7r/PmXL2D4K/+ZHHfpbe4G2Jjm8BKbl84ro5bvUjj/RN+c2Zs9+hA0uPS1qnaLJsRdfZsKTHzRYMaFLhfJgsZxu/07wykYiw=" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" 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" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=debug msg="completed keyexchange" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=debug msg="completed challenge" Oct 31 12:38:35 volumio go-librespot[11722]: time="2025-10-31T12:38:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:36 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:36 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Oct 31 12:38:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:38 volumio go-librespot[11729]: go-librespot daemon starting... Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=debug msg="app state loaded" Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" 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 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" 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 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" 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 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=info msg="zeroconf server listening on port 33211" Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=debug msg="obtained new client token: AADU5l81UYKixer7gPxp1mGy76M1o4Fw1v/vrXgG3fLd4uSAFWL642SnD8aOpdmO+5eE/Fj2xDWhJK0oYRbp86JfIHNMQwAwSoMsA0k0qYc2fy/9ddlrCIrIscP5Fmpnny5nRph6OSvXjYzbjLF5y4ku7mTskQqAHMV55nXlerRmn0avXnosq9HHq3glDbOx9Ak/NxMJkPtvkkxg/ZaH+9cSZAUmJYAcX3tVVzcOXPTm72/4+1OoD5E=" Oct 31 12:38:38 volumio go-librespot[11730]: time="2025-10-31T12:38:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:39 volumio go-librespot[11730]: time="2025-10-31T12:38:39Z" level=debug msg="completed keyexchange" Oct 31 12:38:39 volumio go-librespot[11730]: time="2025-10-31T12:38:39Z" level=debug msg="completed challenge" Oct 31 12:38:39 volumio go-librespot[11730]: time="2025-10-31T12:38:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:39 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:39 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:42 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:42 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 94. Oct 31 12:38:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:42 volumio go-librespot[11752]: go-librespot daemon starting... Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=debug msg="app state loaded" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" 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 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" 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 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" 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 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=info msg="zeroconf server listening on port 41135" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=debug msg="obtained new client token: AAC7gOeHxM9UV6SYDxo4uRRGahMaiFsu/skoB1g9MZ+WelZ23LeuWGmZutC+eAA8/V+pMuoZp/qF+nY95YBQ1TgnuzxCZnBD9cywJGe6yUa3s6CZ2qOXY1eRjQhho4B7HAmXH7NZZLPTud9OkI/nUKqLD769u1ulYgsEk3LjrZ2iJ3gbm1em3dut8e7uQtvYhyWrm0VafDruCtG0+/K632ZIj5QDI4cxMeIBiSezCJeuu7fn1kdLer0=" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=debug msg="completed keyexchange" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=debug msg="completed challenge" Oct 31 12:38:42 volumio go-librespot[11753]: time="2025-10-31T12:38:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:45 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:45 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Oct 31 12:38:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:45 volumio go-librespot[11760]: go-librespot daemon starting... Oct 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" level=debug msg="app state loaded" Oct 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" 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 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" 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 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" 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 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" level=info msg="zeroconf server listening on port 44087" Oct 31 12:38:45 volumio go-librespot[11761]: time="2025-10-31T12:38:45Z" level=debug msg="obtained new client token: AAA9+uR+oPXBvkjXu/YReKhufOj8ZjzUI7XIwk9dzQJDP8VqgbAL/l6H8Ujlz8AAc+BnTk9wSMpMF33qqgbToeG0pjS7WIjcmPmoH5dmdTcKCtYAoJN8C9ts9aLbkwse5OzaTm4O+JW+m/QZpaMSa4fnsaxNyFMb+rv/Ve+1f+ZTO98VqV+6mnMlfGVg5KXg7e27lLFlceuKcr/3kQ3gtv9ikstMTJACZgo7f3TiYEWVBuwQh0DA11I=" Oct 31 12:38:46 volumio go-librespot[11761]: time="2025-10-31T12:38:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:46 volumio go-librespot[11761]: time="2025-10-31T12:38:46Z" level=debug msg="completed keyexchange" Oct 31 12:38:46 volumio go-librespot[11761]: time="2025-10-31T12:38:46Z" level=debug msg="completed challenge" Oct 31 12:38:46 volumio go-librespot[11761]: time="2025-10-31T12:38:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:48 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:48 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Oct 31 12:38:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:49 volumio go-librespot[11769]: go-librespot daemon starting... Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=debug msg="app state loaded" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38: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-gew4.spotify.com:80]" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" 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 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" 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 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=info msg="zeroconf server listening on port 46177" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=debug msg="obtained new client token: AAD/P6PSH/cE30xE1T1Xvoz4DExIRRnWK1fMcezNoHokzRah5pRM5xAIS7/Di5ps3xyng3fouBgzso5zYDOgGiK7KjbTiZj6C78gppX9StK/qLqz5Y9SvBtZZhqWcQpfsZ0Ocd5fWg6csaV6ilNNtVJCf7UaTVWGQvx+F6pfUEKJ5dZ4aoo8gDWjm9LYHug9e3a8D4HXYvWst4QWTFmlcpCN9G4MudmvV0L73mQVoDJndzywN+AF8i0=" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=debug msg="completed keyexchange" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=debug msg="completed challenge" Oct 31 12:38:49 volumio go-librespot[11770]: time="2025-10-31T12:38:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:51 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:51 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Oct 31 12:38:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:52 volumio go-librespot[11791]: go-librespot daemon starting... Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=debug msg="app state loaded" Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" 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 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" 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 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" 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 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=info msg="zeroconf server listening on port 34097" Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=debug msg="obtained new client token: AABhNrQE5hjoMUuZpwUmJFj27PhPAvRKMMJIPXVKnLwM+ozPH+JPByK1le+T6P2UR3QXoUR/UaFPNDHRsS1vCzMs70VfL+ajgngWVHUWKjpuKGBnKp+65UnxmThdkIejNrc7rvvCFnEv8mBErZ77eLY1GZ/ktpf2LBWokqVgro3V2VOIJK2KR6dFxFXp2qnReyZ27Us2h/bkN64PQLlDc08XrP4SbX0Vf1AsZZH7ykLZP5AiH7DO03I=" Oct 31 12:38:52 volumio go-librespot[11792]: time="2025-10-31T12:38:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:53 volumio go-librespot[11792]: time="2025-10-31T12:38:53Z" level=debug msg="completed keyexchange" Oct 31 12:38:53 volumio go-librespot[11792]: time="2025-10-31T12:38:53Z" level=debug msg="completed challenge" Oct 31 12:38:53 volumio go-librespot[11792]: time="2025-10-31T12:38:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:54 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:54 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Oct 31 12:38:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:56 volumio go-librespot[11803]: go-librespot daemon starting... Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=debug msg="app state loaded" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38: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]" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38: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]" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38: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]" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=info msg="zeroconf server listening on port 43273" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=debug msg="obtained new client token: AABr+Sny5kRFQEas5bBzBz96U4yNqaPo+3rYsyPdly61tqQiQdxZFuZqdgjIlhnZpRv6Or1JThvUybFtjrFV3BtIa/cyapYn1fbINThmEZi47xGrckl3A7QtRU/qCcFoSgwH10WBN4H+/i8PUrkBT0bAq41sbjy5ILmO8+Bi4JKi9yn4Ddpv2Ycx4Fdnn1nLJPt5IoHomhh1xzz50PkpsNOL0m+WHjVEeJvKmbX3FjJlXZqWnsODLzM=" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=debug msg="completed keyexchange" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=debug msg="completed challenge" Oct 31 12:38:56 volumio go-librespot[11804]: time="2025-10-31T12:38:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:38:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:38:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:38:57 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:38:57 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:38:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Oct 31 12:38:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:59 volumio go-librespot[11811]: go-librespot daemon starting... Oct 31 12:38:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=debug msg="app state loaded" Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" 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 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" 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 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" 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 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=info msg="zeroconf server listening on port 33387" Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=debug msg="obtained new client token: AABISAIdx00paJCN1sO6Oc4jKfuwBv0b4Axu2rvd8gbc8IXjW2/diNCYK1UGUHHVuhNTSulCb7P94Jy+/5ZDh9Vk9GdB3poqjKpI5J8donb7DI1ta1ZfRAEc0HYSuDD/V86sQyIERZeksLj5AFvMozndYf+Rck9ldD+PzuiEkKyk61RBy/yB5L7zDhrMpgM1GpdKK/xZ6l/vn0ARyRgB0NNddJAiCrMWyNAWt4PmItgYz/vSPZpILmo=" Oct 31 12:38:59 volumio go-librespot[11816]: time="2025-10-31T12:38:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:39:00 volumio go-librespot[11816]: time="2025-10-31T12:39:00Z" level=debug msg="completed keyexchange" Oct 31 12:39:00 volumio go-librespot[11816]: time="2025-10-31T12:39:00Z" level=debug msg="completed challenge" Oct 31 12:39:00 volumio go-librespot[11816]: time="2025-10-31T12:39:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:39:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:39:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:39:00 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:00 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:03 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Oct 31 12:39:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:03 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:03 volumio go-librespot[11835]: go-librespot daemon starting... Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=debug msg="app state loaded" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" 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 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" 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 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" 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 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=info msg="zeroconf server listening on port 38895" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=debug msg="obtained new client token: AAB4xRWQrblq6jBwNdsrzosJEaHoDJKJpT0nPHojBVjx8u6V7IA23EcD/9XyqZpsDM01408LErwIMfJwZjNJWkeY9Tzbl5LzDNFgtm5LGxVhIakeQfdhrHY1xkxF8H7WwaT5DXMxHdXYgdeezZ7nGWk3G3CA6lwBVpRSTXWeSaZj83Mi0y1Z/nD7mRYPJiithRBNlhlSeFcX8LzaYTVYxwp07QX4xzgtlEriHAC8na/dYaXLE40ppSE=" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=debug msg="completed keyexchange" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=debug msg="completed challenge" Oct 31 12:39:03 volumio go-librespot[11836]: time="2025-10-31T12:39:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:39:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:39:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:39:06 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:06 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Oct 31 12:39:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:06 volumio go-librespot[11843]: go-librespot daemon starting... Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=debug msg="app state loaded" Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" 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 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" 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 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" 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 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=info msg="zeroconf server listening on port 42493" Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=debug msg="obtained new client token: AAA4pCLxZrcXRE7Praly5dXug3Vq1m7e0mj/GrDePY8NOLbFnpRB4ewWG6xnSslaS6qemf0vjXfpYkiihheESsGpNwysaRbKSubjdna+Q2wXazjVheBsmJmC+TWPblJEFsEAoiHELPVqVoLuZMeC04mzsR9MRbx2gKpEbOJKO1hUUNPWdR/DKYX9t6NOWgHpuD487+K2rCpN+3DozYMLDbnlAX4ZtZir5ARa2lt3LGdl29reYK+LNTY=" Oct 31 12:39:06 volumio go-librespot[11844]: time="2025-10-31T12:39:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:39:08 volumio go-librespot[11844]: time="2025-10-31T12:39:08Z" level=debug msg="completed keyexchange" Oct 31 12:39:08 volumio go-librespot[11844]: time="2025-10-31T12:39:08Z" level=debug msg="completed challenge" Oct 31 12:39:08 volumio go-librespot[11844]: time="2025-10-31T12:39:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:39:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:39:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:39:09 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:09 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Oct 31 12:39:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:11 volumio go-librespot[11866]: go-librespot daemon starting... Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=debug msg="app state loaded" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" 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 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" 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 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" 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 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=info msg="zeroconf server listening on port 39733" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=debug msg="obtained new client token: AADj4Q5K+BUqR+KuJ6xnQwW1JTw5ytA4EM1JwL3IbUH+9+v6hEi3d5DsB1EZFQqhl8toQ0EC0HiI5mcaHlNDx4PxKR9/tH2LZMlkibnxcYnex5t7H7l3f7P7JDIrWtQxlzdSbiJoKndYdinaG3fbF694JTFEHnckxcfOrqmZjz8JGHxnrwFO53Eij0UNiUujfxdiuCgfAYa4nsM1yPrpnjpGfXv8pBwClvbh5BI5dTlX/s2MG+dn6r4=" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=debug msg="completed keyexchange" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=debug msg="completed challenge" Oct 31 12:39:11 volumio go-librespot[11867]: time="2025-10-31T12:39:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:39:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:39:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:39:12 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:12 volumio volumio[10146]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Oct 31 12:39:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 12:39:15 volumio go-librespot[11875]: go-librespot daemon starting... Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=info msg="running go-librespot 0.4.0" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="app state loaded" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=info msg="zeroconf server listening on port 33243" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="obtained new client token: AAAW81WQfwW4odw351LrNFI62mVyZ3hOXpShwixtdhKGIsF6CHP5DOifbohNBbixhvx0jCuDXu+N9vyf0A0CCMYXnNZCHRFFRHVuARP0CTIp4ed936+9wq8JgX4uXdv3XCoULcxIoBYA6Bb4EDgBQG2WwB7AFuURT1UZAxcX5lS5pmQXn+McugcnksalPCyAd/hzMNC03NwEncV0EtJBMeC19QEo6dCy0WFNOvAuPtu6vSOz7amN" Oct 31 12:39:15 volumio volumio[10146]: info: Initializing connection to go-librespot Websocket Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="new websocket client" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 12:39:15 volumio volumio[10146]: info: Connection to go-librespot Websocket established Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="completed keyexchange" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=debug msg="completed challenge" Oct 31 12:39:15 volumio go-librespot[11876]: time="2025-10-31T12:39:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 12:39:15 volumio volumio[10146]: info: Connection to go-librespot Websocket closed Oct 31 12:39:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 12:39:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 12:39:18 volumio volumio[10146]: info: Getting Spotify volume Oct 31 12:39:18 volumio volumio[10146]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 12:39:18 volumio volumio[10146]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 12:39:18 volumio volumio[10146]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 31 12:39:18 volumio volumio[10146]: errno: -111, Oct 31 12:39:18 volumio volumio[10146]: code: 'ECONNREFUSED', Oct 31 12:39:18 volumio volumio[10146]: syscall: 'connect', Oct 31 12:39:18 volumio volumio[10146]: address: '127.0.0.1', Oct 31 12:39:18 volumio volumio[10146]: port: 9879, Oct 31 12:39:18 volumio volumio[10146]: response: undefined Oct 31 12:39:18 volumio volumio[10146]: } Oct 31 12:39:18 volumio volumio[10146]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 12:39:18 volumio sudo[11900]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-31 12:38' Oct 31 12:39:18 volumio sudo[11900]: 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"