Nov 01 13:51:00 volumio go-librespot[18837]: time="2025-11-01T13:51:00Z" level=debug msg="completed keyexchange" Nov 01 13:51:00 volumio go-librespot[18837]: time="2025-11-01T13:51:00Z" level=debug msg="completed challenge" Nov 01 13:51:00 volumio go-librespot[18837]: time="2025-11-01T13:51: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 01 13:51:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:00 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:00 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51. Nov 01 13:51:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:03 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:03 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:03 volumio go-librespot[18844]: go-librespot daemon starting... Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=debug msg="app state loaded" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51: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 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51: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 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51: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 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=info msg="zeroconf server listening on port 43217" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=debug msg="obtained new client token: AAABxATEFlBmu6B9QXZzqXIR4FG95GEd6CokRR2VaUIAv/WzZvVifS9sfaNJw/XBeBwtRict8HG9mYsdMT6BKs3kCOFIBKPhAEEznTsMrrNKV6hnuup6WRpnNX6mEbdgZr/h2GwUZBejA+aXrhMnWeWgYne+8SnawOa3x6y/KlzsU2HO9QQ4/J+h02R/Fx5wY0uGPCuOMCdJ6r9vEc2KxxeBkcDSFkJ/wLGbzdVnXYMHlWsQecpnU2I=" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=debug msg="completed keyexchange" Nov 01 13:51:03 volumio go-librespot[18845]: time="2025-11-01T13:51:03Z" level=debug msg="completed challenge" Nov 01 13:51:04 volumio go-librespot[18845]: time="2025-11-01T13:51: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 01 13:51:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:06 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:06 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Nov 01 13:51:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:07 volumio go-librespot[18856]: go-librespot daemon starting... Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=debug msg="app state loaded" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51: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 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51: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 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51: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 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=info msg="zeroconf server listening on port 39219" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=debug msg="obtained new client token: AADE2777koRjiF5MKgrnYkOeuZ48g0xQChsqzKOLRBLYS0tlR8UFVR0fdikYDY6w1ELygMYNQxQF5SjSiH8eyWCFvddyYKwBzlvIq/roroc9dSe/xJseV97FF07JtQazNlCo8CzsJMFXYUOXxLj1WGRfHQZxsp8PrZu+aZi4eg0+Y2IFJLLNeG6Ofa4IBrzHUmoVCV/Vh8WwGeGNnA5e+PccmRS9oOPdD21hsjBkeRPWzAnQ+eXlUrc=" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=debug msg="completed keyexchange" Nov 01 13:51:07 volumio go-librespot[18857]: time="2025-11-01T13:51:07Z" level=debug msg="completed challenge" Nov 01 13:51:08 volumio go-librespot[18857]: time="2025-11-01T13:51:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:09 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:09 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Nov 01 13:51:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:11 volumio go-librespot[18878]: go-librespot daemon starting... Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=debug msg="app state loaded" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51: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-gew4.spotify.com:80]" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" 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 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" 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 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=info msg="zeroconf server listening on port 42821" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=debug msg="obtained new client token: AAD9qWHycx9a/NErKOz8GkOw/Q4hgoQ4/0kuh0fpuaAw8QVR28TnVdBVmyDAnkh7X8914q3iDL3/RHa7qGEy0KFcX71LiOBOch8GZ9ZzY/Mjcyjy6rQwpaNu+8B/P45Q6WUuaHd5qF9eDPc0Bbnty4vEVG5KVcP/1bdGa0rFhaqIUFr2psV3PUCGPwj9J4olv5P7N/onMpRxcLkbSF+Oigo0Lg2LhVTZQXWaHtdolm8TePBn91fG/qk=" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=debug msg="completed keyexchange" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51:11Z" level=debug msg="completed challenge" Nov 01 13:51:11 volumio go-librespot[18879]: time="2025-11-01T13:51: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 01 13:51:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:12 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:12 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Nov 01 13:51:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:14 volumio go-librespot[18886]: go-librespot daemon starting... Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=debug msg="app state loaded" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" 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 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" 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 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" 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 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=info msg="zeroconf server listening on port 44407" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=debug msg="obtained new client token: AADRQ3/6gTjLM/H3RrF60xgMSf9BdlB3v/Z+Pn/RcZcTOoun/pxCidx26TDSuk/KmOEpSo9QuQ9mspnGBZQ6wwSLVmPcRoVjbjD9ylbMXhy9VQ6DnZpty9m7TqUMNHO0w8knXKE1eCi0EYlofjTXx/lwOJZ35R6C65RzCR92QH/oSdHBxrX9I5QYNtY4KZS/Z4WmQXipCDJG62Mso94MuIjyyN8eelB6y7hgNeX34qGt4C8Y7ns46LY=" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=debug msg="completed keyexchange" Nov 01 13:51:14 volumio go-librespot[18887]: time="2025-11-01T13:51:14Z" level=debug msg="completed challenge" Nov 01 13:51:15 volumio go-librespot[18887]: time="2025-11-01T13:51:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:15 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:15 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Nov 01 13:51:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:18 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:18 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:18 volumio go-librespot[18909]: go-librespot daemon starting... Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=debug msg="app state loaded" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" 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 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" 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 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=info msg="zeroconf server listening on port 36603" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=debug msg="obtained new client token: AAAS9LGfINBHxGItuaVF4QS40C9LYif6Ugzj+0hqSKiwbl6NerO5Fa7phYHbJdcblkk7WjvnQWo3nUEejXhA7hWZUQff5yd0rTMqyVJgODtYeroVzGO3RgAgmYOlJIFa9jKI3iKR/3GCvNBD2Onhggp8q5VG0Rs5pSNOLsWHIWjXSH7JTKZrwSwI64bAK0w8NG4iotTT1ClOL1mDY90Raerme+gqHdWMLx7s2jDMu8nU7m0ajjDr9Zk=" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=debug msg="completed keyexchange" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51:18Z" level=debug msg="completed challenge" Nov 01 13:51:18 volumio go-librespot[18910]: time="2025-11-01T13:51: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 01 13:51:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:21 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:21 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Nov 01 13:51:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:21 volumio go-librespot[18917]: go-librespot daemon starting... Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=debug msg="app state loaded" Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51: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 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51: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 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51: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 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=info msg="zeroconf server listening on port 42751" Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=debug msg="obtained new client token: AABoP35SWmJSTtDDj0NkuNHz61XDjN+I3T6mr88NT4hmce6JxkJp2AyfkFFzKMfsv3qeD1tvlxz9ccoXueavjFU7hp7dz44n9NnHKT1CGvPlxYsdobj3HeNm8zWfSXvQU14sImqE/b1y2mf+AuH2xQxPP/GNU2iKV9t7tpwfx/lAOVR+S32kH9a1wTkyDFxH+0AZWmCFSgMdOPjO2Hg4/wGXtkJDyYCJT0w2CX+YmnmpkrbTqUPsLEs=" Nov 01 13:51:21 volumio go-librespot[18918]: time="2025-11-01T13:51:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:22 volumio go-librespot[18918]: time="2025-11-01T13:51:22Z" level=debug msg="completed keyexchange" Nov 01 13:51:22 volumio go-librespot[18918]: time="2025-11-01T13:51:22Z" level=debug msg="completed challenge" Nov 01 13:51:22 volumio go-librespot[18918]: time="2025-11-01T13:51:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:24 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:24 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Nov 01 13:51:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:25 volumio go-librespot[18928]: go-librespot daemon starting... Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=debug msg="app state loaded" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51: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 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51: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 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51: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 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=info msg="zeroconf server listening on port 43371" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=debug msg="obtained new client token: AAC3ilGrWFaqs9j/gBS5yQFo7hqEERqC5imtEq9vT84rU+AaPbBDGh2p311nHDpqGMu/7KnHJPr7B7mGrwi+pgXehkRqo/8sRHHbkuH7zHOJXveacvvLjzfxh0zH7I8/fg1ZOP9zP+DxOk8qEGvF7Bq5Y+d3xBf7H7NCgsR27hYnnbNaP4osLkVFMNXLByt7tCe6BXzXrBAj05jsRc0/8EwW/WLZLa7gyf0G5iaYzrse6xWgLLeHK9c=" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" 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 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=debug msg="completed keyexchange" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51:25Z" level=debug msg="completed challenge" Nov 01 13:51:25 volumio go-librespot[18929]: time="2025-11-01T13:51: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 01 13:51:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:27 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:27 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Nov 01 13:51:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:28 volumio go-librespot[18950]: go-librespot daemon starting... Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=debug msg="app state loaded" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" 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 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" 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 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=info msg="zeroconf server listening on port 45615" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=debug msg="obtained new client token: AACL9QFxe3KSBEFj5n+lCi7avMa35opCEz/OXRdW8m1jPUb5YWm0QKKHkMaolynePe6I9/Bf5eaOnSM3+ySpxpnE18Sluc1N+TJqynLxluAYcNkcIdtuitUZXrKcyLPrbFNoX7D2iBWsj/fbLlozfZ25DdSTNu4moptYXlNBMIuMXAsPM8hWKHQiIvjtV3B3r+mBSTdWH2Csm9wIZG7Ex4PRL/Fv53965W1Cz56TJY7uLZm4LlkMJrI=" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=debug msg="completed keyexchange" Nov 01 13:51:28 volumio go-librespot[18951]: time="2025-11-01T13:51:28Z" level=debug msg="completed challenge" Nov 01 13:51:29 volumio go-librespot[18951]: time="2025-11-01T13:51:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:30 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:30 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Nov 01 13:51:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:32 volumio go-librespot[18959]: go-librespot daemon starting... Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=debug msg="app state loaded" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" 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 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" 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 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" 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 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=info msg="zeroconf server listening on port 41859" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=debug msg="obtained new client token: AADK0r/0q0C+obdqovboQSJCJgCab+NBMH/ZlZtDEthhu8JB/Wd6mD9zznHFfS7W10WvV6LMN88N3Z+ysp3R/1XvjfzyDEP2lr7RDk/MtDWzmleoR0WbNHqEDQMc5ppY22NYmMxNEINjbt3y3fNW8JbtD0qniboymR6WmJMbCaVkKO4T2jYM4YpMOXjOxSvRB74x3B1Lg/Pzp3jcC7hIOPYKVL/Gj2nYqEsKB+HHQaoHNSvliBXL3UU=" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=debug msg="completed keyexchange" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51:32Z" level=debug msg="completed challenge" Nov 01 13:51:32 volumio go-librespot[18960]: time="2025-11-01T13:51: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 01 13:51:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:33 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:33 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Nov 01 13:51:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:35 volumio go-librespot[18967]: go-librespot daemon starting... Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=debug msg="app state loaded" Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" 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 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" 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 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" 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 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=info msg="zeroconf server listening on port 36753" Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=debug msg="obtained new client token: AAARA0IwgshNVBKGyswc+lUeIc/Ohp1QyHgBfdW7jrqdVY3GXXlzfZjhuUo7zOslxCFT86jnVIwis6/o2iFvKpeuCd9kO2vaDnkQZUXDT4LpSQn08NCqufvMGi7+7jy3x2ob4Hrlg7hJheEwVCe97vySy88Dobo7pIzRNY2g+vvLD3bAaf3IS2/A0roOxPMbZC/HHJQkjw0A0COej738SzQtH2Fd8l4+wN4gvMWNEFav60dyAh6U3M4=" Nov 01 13:51:35 volumio go-librespot[18968]: time="2025-11-01T13:51:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:36 volumio go-librespot[18968]: time="2025-11-01T13:51:36Z" level=debug msg="completed keyexchange" Nov 01 13:51:36 volumio go-librespot[18968]: time="2025-11-01T13:51:36Z" level=debug msg="completed challenge" Nov 01 13:51:36 volumio go-librespot[18968]: time="2025-11-01T13:51:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:36 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:36 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Nov 01 13:51:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:39 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:39 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:39 volumio go-librespot[18989]: go-librespot daemon starting... Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=debug msg="app state loaded" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51: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 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51: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 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51: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 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=info msg="zeroconf server listening on port 32853" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=debug msg="obtained new client token: AABZ6Vms/QsP4qV3ZiA8GjDEaXXDc29X54KqY52fW6d4z2T/DkAUolAZ24LKTnkCKmj3UXIXHTfKg3RVyh/RnpbJhbE2j2XSzSl691trxfC4+wsKCD/jxZBZVn1CZFb9gmEADB0oF+tLTOBg6uEW50W0tSILoHTA/wc01eRUG9ixt8vGsXsN8jJy+FDbAOTz4f+yu+F7xb2AVNEJQuiAQRtIJWVGTKj9rYpGsqdCx8FxN/DpbhKGknw=" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=debug msg="completed keyexchange" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51:39Z" level=debug msg="completed challenge" Nov 01 13:51:39 volumio go-librespot[18990]: time="2025-11-01T13:51: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 01 13:51:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:42 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:42 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Nov 01 13:51:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:42 volumio go-librespot[18997]: go-librespot daemon starting... Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=debug msg="app state loaded" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51: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]" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51: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]" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51: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]" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=info msg="zeroconf server listening on port 38043" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=debug msg="obtained new client token: AAC6487fL6PNzNEfPPae7wXk8QecLgi55V1MMwY1jplaSjq86fNyETZ8Bm6E91FWwb0zczDmjlMdnaQCp3v8GtTMw9pTE99/E0X/972P+CghqpKm+N46z6jX8MJ91oDO1Ghh9uDpZKHdmepT1hkcR2slb29yX6WTgRxJcm89hY4yj1/xTpLrIMzAx/pUDpGV0RS7W88rQYmz7EW+oYS9PdzLaUNWUVHQvpiUzuYS4b3Bg+hhCxwitjs=" Nov 01 13:51:42 volumio go-librespot[18998]: time="2025-11-01T13:51:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:43 volumio go-librespot[18998]: time="2025-11-01T13:51:43Z" level=debug msg="completed keyexchange" Nov 01 13:51:43 volumio go-librespot[18998]: time="2025-11-01T13:51:43Z" level=debug msg="completed challenge" Nov 01 13:51:43 volumio go-librespot[18998]: time="2025-11-01T13:51:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:45 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:45 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 01 13:51:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:46 volumio go-librespot[19008]: go-librespot daemon starting... Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=debug msg="app state loaded" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" 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 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" 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 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" 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 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=info msg="zeroconf server listening on port 40459" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=debug msg="obtained new client token: AADxVNdtzez+x6GWm5fqwSKb4xfcXA/ZTgWGWiGUMtyfPqCRIdsFte/EPbXKJleGtTaKYFqtt1ACSQBqnW4F91N7fK8e8BA7lnlph2HgKT2w9zxqD3UmX2a0FkzZtMWeQMMD11VbN6E8hgd72NW6S80uKgq0WMPA2irxRI34C0umsG/3LUqj1g4AZzwkBAFgLi4Rot2XcVTPxw/b706F3mRM6wo1lQ1noHM1Rj4DV7tdaUMMa+jBDyg=" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" 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 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=debug msg="completed keyexchange" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51:46Z" level=debug msg="completed challenge" Nov 01 13:51:46 volumio go-librespot[19009]: time="2025-11-01T13:51: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 01 13:51:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:48 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:48 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 01 13:51:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:49 volumio go-librespot[19030]: go-librespot daemon starting... Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51:49Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51:49Z" level=debug msg="app state loaded" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51: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]" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51: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]" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51: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]" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51:49Z" level=info msg="zeroconf server listening on port 41953" Nov 01 13:51:49 volumio go-librespot[19031]: time="2025-11-01T13:51:49Z" level=debug msg="obtained new client token: AAD14ivCLUz8kTqf7ATo/8KrogXzcsyvwMyk43RXwv8fVScP9EFSJPZHEQOxLDdSofrssAp4fI8TTyL2yrfob80D//w9TdpzUsU2ArjCr9dhs0qG8itokENBav0EyXqkKORYf+sV04Q+jL4yoM3o/d9m2Ro0rHteS4fThXow1TjDj916Nb6bcAtq394jhW/jfok80i4OU1PkourrstCaAv6dBBnM9+7jXfn26/qFGteCIgwMKGOlORw=" Nov 01 13:51:50 volumio go-librespot[19031]: time="2025-11-01T13:51:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:50 volumio go-librespot[19031]: time="2025-11-01T13:51:50Z" level=debug msg="completed keyexchange" Nov 01 13:51:50 volumio go-librespot[19031]: time="2025-11-01T13:51:50Z" level=debug msg="completed challenge" Nov 01 13:51:50 volumio go-librespot[19031]: time="2025-11-01T13:51:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:51 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:51 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 01 13:51:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:53 volumio go-librespot[19039]: go-librespot daemon starting... Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=debug msg="app state loaded" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" 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 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" 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 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=info msg="zeroconf server listening on port 34323" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=debug msg="obtained new client token: AACmgg93cqngwsqBJWhvXPVtTiYJAJiALFvKxdJwitDUjFoDoo/iOy4jovtMun4WZP8d+MSdrqPitqD898ztpTmguWck6fuOQrnng8/3/C7ac53uTtvcK/ZdGea5gNWIhNQ0aKaPv++t0dzYYCvKKEXQAvOfU622MSEQ0YBxh9Be0oPwd+Gv5aSBc+gexpUte+PG4zcgN28VUrPcrxfSOFX9fNI13QBQbAacDB3OtonjEdt73rEMamQ=" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=debug msg="completed keyexchange" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51:53Z" level=debug msg="completed challenge" Nov 01 13:51:53 volumio go-librespot[19040]: time="2025-11-01T13:51: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 01 13:51:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:54 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:54 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:51:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 01 13:51:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:51:56 volumio go-librespot[19047]: go-librespot daemon starting... Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=debug msg="app state loaded" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51: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-gae2.spotify.com:80]" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" 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 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" 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 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=info msg="zeroconf server listening on port 39581" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=debug msg="obtained new client token: AADiu22QcX5Df1BOBoHlcACLTLj5e7mytXKQkECifi46I1eoxMtp2fHXLCXY74Vs5D17TFBi1mdXIFv8WNEPXlGsaLhbdF0zECP4wQn5jnwEEfXty7VPpC5KtJSlkqoKejAAcd+G7rHjNBE4alCxEbgSLbaT/uZvLpPcv/ScJP5zfsF2BKKwGQNurkA++HXCB/uKz7YGJE5zlcMzJBiaKpjJIoBvALWo38jS8rZFR4ek44LhFuzRKXs=" Nov 01 13:51:56 volumio go-librespot[19048]: time="2025-11-01T13:51:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:51:57 volumio go-librespot[19048]: time="2025-11-01T13:51:57Z" level=debug msg="completed keyexchange" Nov 01 13:51:57 volumio go-librespot[19048]: time="2025-11-01T13:51:57Z" level=debug msg="completed challenge" Nov 01 13:51:57 volumio go-librespot[19048]: time="2025-11-01T13:51:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 13:51:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:51:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:51:57 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:51:57 volumio volumio[18300]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:52:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Nov 01 13:52:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:52:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 13:52:00 volumio go-librespot[19069]: go-librespot daemon starting... Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=info msg="running go-librespot 0.4.0" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="app state loaded" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 13:52:00 volumio volumio[18300]: info: Initializing connection to go-librespot Websocket Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="new websocket client" Nov 01 13:52:00 volumio volumio[18300]: info: Connection to go-librespot Websocket established Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52: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 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52: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 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52: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 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=info msg="zeroconf server listening on port 35041" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="obtained new client token: AADaaENnMPrJaz6iTf/aAigmn4CIRH0gAf+63h886FZvHOkC30yP2o+K4XolnPtcoddSx2v3kMLRX1THatyRZ3lEsbcnp10fBTM1Np+sqXstPexQCxj7KLxWfdA0DFMSdx8TlyG++04G/GAnqudHlN0R+4WkZi65V01o66oqnKGgFjoMfMxXLK1TXMJcxocVtCvSa/A7dktRFhE4Fyw9j00My8tMPGqVjSFPpOox3ZljYbCRnBMTjuk=" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="completed keyexchange" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52:00Z" level=debug msg="completed challenge" Nov 01 13:52:00 volumio go-librespot[19070]: time="2025-11-01T13:52: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 01 13:52:00 volumio volumio[18300]: info: Connection to go-librespot Websocket closed Nov 01 13:52:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 13:52:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 13:52:03 volumio volumio[18300]: info: Getting Spotify volume Nov 01 13:52:03 volumio volumio[18300]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 13:52:03 volumio volumio[18300]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 13:52:03 volumio volumio[18300]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 01 13:52:03 volumio volumio[18300]: errno: -111, Nov 01 13:52:03 volumio volumio[18300]: code: 'ECONNREFUSED', Nov 01 13:52:03 volumio volumio[18300]: syscall: 'connect', Nov 01 13:52:03 volumio volumio[18300]: address: '127.0.0.1', Nov 01 13:52:03 volumio volumio[18300]: port: 9879, Nov 01 13:52:03 volumio volumio[18300]: response: undefined Nov 01 13:52:03 volumio volumio[18300]: } Nov 01 13:52:03 volumio volumio[18300]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 13:52:03 volumio sudo[19091]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 13:51' Nov 01 13:52:03 volumio sudo[19091]: 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"