Nov 01 06:21:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Nov 01 06:21:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:01 volumio go-librespot[15534]: go-librespot daemon starting... Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="app state loaded" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=info msg="zeroconf server listening on port 39797" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="obtained new client token: AAC16IidvCp5k45pQirZNmjGIEOGLwCWb/tq2+rA/SwOSIer2m4/boskcCMuKuZAKrz8VbNJ0sDEYQnJfSKsePn6si7rpOAy5EzkfMStrkR2oIddi1cAtPkxUQfxXNyruH8VPl3/OqcDu54okJz9n1IkNKu26YaYwWVDONdQHhx3k0NFItXbOhrVuMJbiwseXck1m3FMTntPQjmABcJpnwFkvjJ9cq3kTjmQIW2YCeH8lha4eK98XcM=" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="completed keyexchange" Nov 01 06:21:01 volumio go-librespot[15535]: time="2025-11-01T06:21:01Z" level=debug msg="completed challenge" Nov 01 06:21:02 volumio go-librespot[15535]: time="2025-11-01T06:21:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:02 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:02 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Nov 01 06:21:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:05 volumio go-librespot[15546]: go-librespot daemon starting... Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="app state loaded" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=info msg="zeroconf server listening on port 46677" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="obtained new client token: AADh6h7Vh55EFWbtQehhAdAK/9TDKmknSidYP3x5yX3Lrg/jc06JVCmzwQLNY4z5XjWtLvTEdUU7+IQJCwP+yBKPVmmjjbPdDi44g/uv1ApdtuEgwtpliiFUz/eApIXZeft+sBx5sGL1TVHVLjMMPajjqv7lhfcZ7Ziobesu7ExdOfABZ/iKEQqyPYWgjIcCji8V5dMalNZC2bj5tbBC+x5swCsBT/8bDZ8zT+kNN5wzdy8dvXwnGMI=" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="completed keyexchange" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=debug msg="completed challenge" Nov 01 06:21:05 volumio go-librespot[15547]: time="2025-11-01T06:21:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:05 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:05 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:08 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:08 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Nov 01 06:21:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:08 volumio go-librespot[15568]: go-librespot daemon starting... Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="app state loaded" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=info msg="zeroconf server listening on port 39439" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="obtained new client token: AAA97A5in2omUDJXqiS7rPdHsYnrwop54wGvg5zfKhIOYGWQoB4dpTRzHbsSNx5uNt+k8HzIeX3Ae2Q6S6n6prlxVXz44q4V+MkTKxP9nT5f/zTnjUoDgEpyI9+6nk95T+DvOuqS4xPguhJxRPb5TUpjAI+eluW7TDBXqEeauOwdSFLCfst+AYTA3oDLa9YN0pH8k253OABsR5d+LqKdHVyTX8mT08Q2t5zUNoOUJd5VCVoFmICGjrs=" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="completed keyexchange" Nov 01 06:21:08 volumio go-librespot[15569]: time="2025-11-01T06:21:08Z" level=debug msg="completed challenge" Nov 01 06:21:09 volumio go-librespot[15569]: time="2025-11-01T06:21:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:09 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:21:11 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:11 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Nov 01 06:21:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:12 volumio go-librespot[15576]: go-librespot daemon starting... Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="app state loaded" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=info msg="zeroconf server listening on port 44581" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="obtained new client token: AAC7JqmOliyY8b+lUppSUT6QjbPGjTqTTcZ1G+MwJr+cVR2CZzoIjt55QK/nH6UVjPShbLd/gPHR2Q33Mqcb7jAWa3iGx7jTUO8A2t88kWjpMzT9ZYVYwNTpxj8eeP6sDi+a991LCnmfDRuOmzMLhBHmVbYD0dORwaU9i64nF4szRqogJsDs+oqwUVWYPP0fslMKOdQF6fpdwmXoWLJmImmr8g2BdHq5+/04YNhI8fDy4OxDPdWFx2M=" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="completed keyexchange" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=debug msg="completed challenge" Nov 01 06:21:12 volumio go-librespot[15577]: time="2025-11-01T06:21:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:14 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:14 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Nov 01 06:21:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:15 volumio go-librespot[15585]: go-librespot daemon starting... Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="app state loaded" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=info msg="zeroconf server listening on port 45625" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="obtained new client token: AABULD7Mb9S9wD6VP6A+3uY78+XymRdj6qCBftKzVIFuYt+03muNAiM/wME2FT3pG+Qtk7KAx16u9cgomHSGAAaS2Thw6yH7k4UBbP6hOiS0NVvzp6PSOMK/7LnENiEtbbbAY2ECGgRf6M0DrQkrt9VXVXqtTPIudQZodqW8MFKj/Jw9rNLOUk0nCCKKq7faY3lP8L+1xC8TiAmTQvQGayQhiq7sxvtgIv6nD0QqRSam5W6rCVHuAV0=" Nov 01 06:21:15 volumio go-librespot[15586]: time="2025-11-01T06:21:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:16 volumio go-librespot[15586]: time="2025-11-01T06:21:16Z" level=debug msg="completed keyexchange" Nov 01 06:21:16 volumio go-librespot[15586]: time="2025-11-01T06:21:16Z" level=debug msg="completed challenge" Nov 01 06:21:16 volumio go-librespot[15586]: time="2025-11-01T06:21:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:17 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:17 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Nov 01 06:21:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:19 volumio go-librespot[15607]: go-librespot daemon starting... Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="app state loaded" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=info msg="zeroconf server listening on port 36077" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="obtained new client token: AAAKIG/XQ5zEHqFp0GwMNU0HgD55sQdwGQ+hTp7oHVb3kmKOlkJmeZBzKa0tBxsp50oRSvJAJQJgo6hjq7SPlDlhce2whHU4TR3Wq00swOMnGIZEgblVvOtfuCeSZqcvUsRZMazXIWt/uqRfoIPI/0D8uY6o2NECttivU+WIJGJIn+TZRYl8xGY9IXZWai3pMYi9VfEAwl6jcvBQU+xpZPhtMg9eQ6S7UR9Mx9p38vm4o8pw8hzODoU=" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="completed keyexchange" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=debug msg="completed challenge" Nov 01 06:21:19 volumio go-librespot[15608]: time="2025-11-01T06:21:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:20 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:20 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Nov 01 06:21:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:22 volumio go-librespot[15615]: go-librespot daemon starting... Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="app state loaded" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=info msg="zeroconf server listening on port 41333" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="obtained new client token: AABQLyZh7ZtGc8XlXY0BK+2sHqPMEzGNOihfK5uiwtcCfrg/GYSj0CdkgtLnkP/xh79Q3yN+XSMuu9gLdMGneDSEt+kImyCCW8z4AauLlvTsGgVDHXpykWj0H0O8xUdfd6TXvZmAx0faCv4NPRchiqnCUs2bYH3/g5w6tQwdgfdBjgVB5N6OhLGCea2vJ6hQ9GnQ75SbZQ1cuJSGwLw5XGiA9KalvjcXVwhP+X2/2d6d8ivrOzZVnhE=" Nov 01 06:21:22 volumio go-librespot[15616]: time="2025-11-01T06:21:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:23 volumio go-librespot[15616]: time="2025-11-01T06:21:23Z" level=debug msg="completed keyexchange" Nov 01 06:21:23 volumio go-librespot[15616]: time="2025-11-01T06:21:23Z" level=debug msg="completed challenge" Nov 01 06:21:23 volumio go-librespot[15616]: time="2025-11-01T06:21:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:23 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:21:23 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:23 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Nov 01 06:21:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:26 volumio go-librespot[15627]: go-librespot daemon starting... Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="app state loaded" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" 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 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" 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 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=info msg="zeroconf server listening on port 39543" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="obtained new client token: AABh/E8C2vRDQrE5T8wdqnjcFbHsMmZ5YfI0gCFMBg7PGmOzGZS59+OwzGyh7bpFulOcN/0TXsomiL7Y78I2W+/NgYaaqKQmZEjki2oYODT3nHecYPatC6vRWIQGXST90HRNTyqx7bPOTdx5KKFCcdRT2sOB/EKPCJ19w6/MPLLbBtg8bjpZAnfaN46iviDQdkzY/TKDrM7AuuJHsHK7C4DjWCNHEYObphkxI8TOnsIILPmycdLQ8LE=" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="completed keyexchange" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=debug msg="completed challenge" Nov 01 06:21:26 volumio go-librespot[15628]: time="2025-11-01T06:21:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:26 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:26 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Nov 01 06:21:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:29 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:29 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:29 volumio go-librespot[15649]: go-librespot daemon starting... Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="app state loaded" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=info msg="zeroconf server listening on port 34823" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="obtained new client token: AABPJ1j1Fq3icCCy71wxmTShOQWQAoVroZDiVSmXEsTemelrDN+iQBMkuc+IS5y1YV7lAnJ19JuGBonUXE/RSLhqkcxljkrDHVXuTyGbc2YT1tcZdvb9FJiqQnPwjceFSEHVgeZdxljSabVwxAOlfeVKYiVtzQIEGaDK15pJrXv5l+xMj4zl/xNQRCB5AebeoHEisG3LXBRvsjg1/75rSmQrMlplReH6WA71DOZVzjrxOH/1gmhxoKI=" Nov 01 06:21:29 volumio go-librespot[15650]: time="2025-11-01T06:21:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:30 volumio go-librespot[15650]: time="2025-11-01T06:21:30Z" level=debug msg="completed keyexchange" Nov 01 06:21:30 volumio go-librespot[15650]: time="2025-11-01T06:21:30Z" level=debug msg="completed challenge" Nov 01 06:21:30 volumio go-librespot[15650]: time="2025-11-01T06:21:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:32 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:32 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Nov 01 06:21:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:33 volumio go-librespot[15657]: go-librespot daemon starting... Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="app state loaded" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=info msg="zeroconf server listening on port 35183" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="obtained new client token: AADxzkJ6gHOQp3Z9FH+M8TqQ1ax9WsmPJtI7q/P4jl3eW0jZKcX88+tYH7I3qQfKo0EYrkloi46VJWYOgmdcR1FQoCfMI/qhorr8np5SIwqbgDtBsu/En3Ob7eHsLfJqCxw0EfYR5Wp3AR16gMYzBFZTthjRPSLSl5Q1NT8YuLlSCiBYi2PrSybaYxC0pYy8Qsc60bb1s9NwUbEVouDq5WBnmLsWNCJuruEqAOemeo1MunCkxIGRrCI=" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="completed keyexchange" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=debug msg="completed challenge" Nov 01 06:21:33 volumio go-librespot[15658]: time="2025-11-01T06:21:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:35 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:35 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Nov 01 06:21:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:36 volumio go-librespot[15665]: go-librespot daemon starting... Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="app state loaded" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" 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 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" 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 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=info msg="zeroconf server listening on port 36309" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="obtained new client token: AACgqXjcirlqwNsE2GehvND+/M9puRUhbI5LUhBq353OglMJqSAxyJzLIadzisMpZizOchPlQi7VijeR/nzMLHWtVCRvQH5g0EWRGa5xX0sGoSlcLp2113H/cmuPXbemw9QMwf0CPBT0HMFdno8eAOZ7mdnMRUsWUNg7bca/4YGQ7DumZjecCldjc90QG4TkCcOfsSC01+C/8lBnVvZj2MrtN+BYZuyKfJd6V8t+/VYZrrHC/lzuB0E=" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="completed keyexchange" Nov 01 06:21:36 volumio go-librespot[15666]: time="2025-11-01T06:21:36Z" level=debug msg="completed challenge" Nov 01 06:21:37 volumio go-librespot[15666]: time="2025-11-01T06:21:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:38 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:38 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Nov 01 06:21:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:40 volumio go-librespot[15687]: go-librespot daemon starting... Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="app state loaded" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" 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 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" 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 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=info msg="zeroconf server listening on port 43249" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="obtained new client token: AACv7srmqtVbazRw6qUUINPm2pVQg7PwzurGywDgj3MWPZ0g9WAbWc9JRJqBHrHy3i65NeBAgZ+k5t5jgD6qu4t34mFF4roekBenk5ngOg9hOj9lywlRnX4U4BaCHD832eVrYIK2kizEMrWWNZa529fl1hCPQ7FZoin0y6zNm3TAeN4EFE6h9S56CpCIVpwbw3kov7QJZfEu3Bw7vDRsRn31SpOn1EdqZ5UEqS58xxpzDzblpAlPs4w=" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="completed keyexchange" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=debug msg="completed challenge" Nov 01 06:21:40 volumio go-librespot[15688]: time="2025-11-01T06:21:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:41 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:41 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:42 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:21:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Nov 01 06:21:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:43 volumio go-librespot[15699]: go-librespot daemon starting... Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=debug msg="app state loaded" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" 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 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" 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 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=info msg="zeroconf server listening on port 39247" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=debug msg="obtained new client token: AAAYk6CRVIMPp/JerTbvufGIXqjylkzqltCpIRHlKScA7f93uyH3vZ+CYL8PQc2f+sJrdJDl4EWBgT2Vl4MDYt02HKOhHMiywrNLpkYwiFHiZdXT/zaa8srGiJIzGlD0dFQv+f9RI+rfQrhU3bUQX0ZWZwEZY3UzSKDCWL6R2VhrOB/aVxMifQb0wyd+Luv8cXVV5CNHyvxIHCCuzPmTbtG81TfR4aGfC7ZY7wiYxadHGhKzDeX3L5w=" Nov 01 06:21:43 volumio go-librespot[15700]: time="2025-11-01T06:21:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:44 volumio go-librespot[15700]: time="2025-11-01T06:21:44Z" level=debug msg="completed keyexchange" Nov 01 06:21:44 volumio go-librespot[15700]: time="2025-11-01T06:21:44Z" level=debug msg="completed challenge" Nov 01 06:21:44 volumio go-librespot[15700]: time="2025-11-01T06:21:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:44 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:44 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Nov 01 06:21:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:47 volumio go-librespot[15708]: go-librespot daemon starting... Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=debug msg="app state loaded" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" 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 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" 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 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" 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 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=info msg="zeroconf server listening on port 34775" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=debug msg="obtained new client token: AACU/Dk8Jcclqdd6XNlsYb5ngcmDylfOnLQIhaXD13cx3h7r+4NAvdzN0fE2NN2/VqXVVECSHLyg7MNcipkcvaT3Fwjirb3RZCdXMTmPo9RksNHfo70hvuwmSgOLphdES0B1Ov35jnotsOR9gZg3c26cWyY15ikLOQZh4yU3Y0O1GDGkGaxGh6yQbsdTIITIKRZYlqNPpTJEcEj/P4h4Op4ZFfsrSqqZMQM2tc/USLsfCo6k/r8LyUY=" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=debug msg="completed keyexchange" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=debug msg="completed challenge" Nov 01 06:21:47 volumio go-librespot[15709]: time="2025-11-01T06:21:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:47 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:47 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Nov 01 06:21:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:50 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:50 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:50 volumio go-librespot[15730]: go-librespot daemon starting... Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="app state loaded" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=info msg="zeroconf server listening on port 44261" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="obtained new client token: AADJmUKZVDVBV8LuPIXSfm2owGx9LXzzKyl9WnBG18BiH6NceoJCieBDK0RjVJVLei8WHDUexgmjsv/SGxjuX0JxXRSghXTpA/DISSsrJY9aRbPecxesKerT1D+K9rguGrW93EEMKsM3xdRrA4VVpPehiBDMWOdlwDiA9tPc+VaH0N6dcRBYf5s+ezeuwX9PUXR4AqS7luWNuSrPlkT+peyhLaDdH8qp10FtdSdpbHley+zpM+BAMto=" Nov 01 06:21:50 volumio go-librespot[15731]: time="2025-11-01T06:21:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:51 volumio go-librespot[15731]: time="2025-11-01T06:21:51Z" level=debug msg="completed keyexchange" Nov 01 06:21:51 volumio go-librespot[15731]: time="2025-11-01T06:21:51Z" level=debug msg="completed challenge" Nov 01 06:21:51 volumio go-librespot[15731]: time="2025-11-01T06:21:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:53 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:53 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Nov 01 06:21:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:54 volumio go-librespot[15738]: go-librespot daemon starting... Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="app state loaded" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=info msg="zeroconf server listening on port 41225" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="obtained new client token: AABwsqlzv1wI4e9SxL9shMlcyhrYHxBAO0kh9kV1nAEJJ5SoBn/mZj+blUmMHORdJLyGAw37kZ3TSjrZEXwJ3gfH2r5t8F+Md79EqtriJZv+HyMzfVze6E2X3o9hE2XKpU8UbNiOTV0MY/ckccr8cR4Jrw2XSi4HAwEPM75vfXIl2Q7ImYKhTnOUeXz+Ww6XdLsZQomTG183L7inumSBlphj5hxt3fkOqVRUlk0Ygqi8YkluVCkjqOY=" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="completed keyexchange" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=debug msg="completed challenge" Nov 01 06:21:54 volumio go-librespot[15739]: time="2025-11-01T06:21:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:56 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:56 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:21:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Nov 01 06:21:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:21:57 volumio go-librespot[15746]: go-librespot daemon starting... Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="app state loaded" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=info msg="zeroconf server listening on port 35771" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="obtained new client token: AADjdRS+4ua1VlWAgC6EQhoX/NWVH5434RzcJr7feiqV13bnWIP4Re/hPbopbjoSlEJV03hwiUUkHuBiaWdrtSERwC5gjHJAZLf19Zac12NP1NbZTUuRcvEzqcnrr2Vrais37WTE8u3a6oInvWIIMbOK3ZetBQ+CCXk2BzGhnhgOtdMxhK036Q1rZq+O7iUIAOgcR51J5GHI36zcMeUEZe2jcux8uNEYRmLd9dQxgLtNqEQ6jHHhPJY=" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:21:57 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="completed keyexchange" Nov 01 06:21:57 volumio go-librespot[15747]: time="2025-11-01T06:21:57Z" level=debug msg="completed challenge" Nov 01 06:21:58 volumio go-librespot[15747]: time="2025-11-01T06:21:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:21:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:21:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:21:59 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:21:59 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Nov 01 06:22:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:01 volumio go-librespot[15768]: go-librespot daemon starting... Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="app state loaded" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" 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 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" 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 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=info msg="zeroconf server listening on port 45679" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="obtained new client token: AAAE6qBLuga+dBk0LasucB5w5lRmOvlJiGRyV+fayfp9JFWYNIOqXrlpt1p023ZrNGbAFJCuV33kVGj5kVbMePVgucV6J8BRW6o36x3Tsjr0OKX7r07nMK+SwwL8pbWB+vROM6QIwKjV6x0c1TafPu159KAHMBsubcEHcaK5XuZyw4ctXT7/72ypQXkPzlIoC05+9AxRfl6ctfdE/A0Wpsb7jH1uHJNS+7aX6GCbb5QtK0gPDE10UCs=" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="completed keyexchange" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=debug msg="completed challenge" Nov 01 06:22:01 volumio go-librespot[15769]: time="2025-11-01T06:22:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:02 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:02 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Nov 01 06:22:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:04 volumio go-librespot[15779]: go-librespot daemon starting... Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="app state loaded" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=info msg="zeroconf server listening on port 46847" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="obtained new client token: AACf3E9eI1ouChta5bkrVZwm9lwER7JxHRiS3HbuF0ROjRTAhlSh2/V0mdwIyFoAVThciE3iIemoz61gqKe0zE3hptO2pMAFXi8Tz4J4h30hfxq/sNoWD12q6V0pc2qNdFn3qDSfs9TgWdkF8YXfkiQxC47B5QWZ0wQecg6Ay1BN61h4nRyNIRgxo/Jz9VxwDO4QOfwLfBiZF34c1QsN1H2H+qRsfQrt8IgX5cTZf1H2sL8xROOEOiw=" Nov 01 06:22:04 volumio go-librespot[15780]: time="2025-11-01T06:22:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:05 volumio go-librespot[15780]: time="2025-11-01T06:22:05Z" level=debug msg="completed keyexchange" Nov 01 06:22:05 volumio go-librespot[15780]: time="2025-11-01T06:22:05Z" level=debug msg="completed challenge" Nov 01 06:22:05 volumio go-librespot[15780]: time="2025-11-01T06:22:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:05 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:05 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Nov 01 06:22:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:08 volumio go-librespot[15801]: go-librespot daemon starting... Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="app state loaded" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=info msg="zeroconf server listening on port 35915" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="obtained new client token: AAAK+mAsLYxClsccQKrro1SpOxR9ynl+6OZa5KUclDhsw0x73WgEw5TeiStGLBJ6TOaIbIXXOJNZi1vxNpGxqiDc61TarvA2KnGtWJ012xiOh3H1PHAe8Rhxe+8OwRUSmWjvA5x5qyYJ8I86ezSrPlGdbHxNYNF+d9bx1+WnqgKrKcwSAnA3UZ/vmatpsHmfd1Hx2qnftC1M6XN36zo0qfkHvP1wDdRzLCV7oilvJCtbJUcDclVvckM=" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="completed keyexchange" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22:08Z" level=debug msg="completed challenge" Nov 01 06:22:08 volumio go-librespot[15802]: time="2025-11-01T06:22: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 06:22:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:08 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:08 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Nov 01 06:22:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:11 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:11 volumio go-librespot[15810]: go-librespot daemon starting... Nov 01 06:22:11 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=debug msg="app state loaded" Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22: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 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22: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 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22: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 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=info msg="zeroconf server listening on port 45519" Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=debug msg="obtained new client token: AACBP1iWPM+QKjA4e1VD6qRzZjHTfAImmwlSpCQ+/Lq3H0dN842tHisHL1RJr76qnKW3ULruu/gJjR1R+8O0aPt4fsYp/Jkj+OCOzgfDmzz8j8P96F/1e4VxYJxktNMpvMTUlh/xHpmam95TLwfb0EGiDN2k/RzLs2qFoGHzvgciLOdyKlXCnIC2FipaXUfj+4Qt6fVrLc5JE4+5mOmph/n/yrJBY8ltq+VpQL4zmvxj8BLxQAzPkbg=" Nov 01 06:22:11 volumio go-librespot[15811]: time="2025-11-01T06:22:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:12 volumio go-librespot[15811]: time="2025-11-01T06:22:12Z" level=debug msg="completed keyexchange" Nov 01 06:22:12 volumio go-librespot[15811]: time="2025-11-01T06:22:12Z" level=debug msg="completed challenge" Nov 01 06:22:12 volumio go-librespot[15811]: time="2025-11-01T06:22:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:14 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:14 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Nov 01 06:22:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:15 volumio go-librespot[15818]: go-librespot daemon starting... Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=debug msg="app state loaded" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" 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 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" 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 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" 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 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=info msg="zeroconf server listening on port 34885" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=debug msg="obtained new client token: AACoPfSnx9NaFcvvgv400JZqU4WeeE7ycz2+BMnBZupE1nQUZPWQC2OARbLTlVGqoW/16RpD01e6UsbBa9UJ7s6zxLkCfrYP0paeMGhVW9QUYFsmowyTRMjC0Dzc9cVBfy1wELctEj6ARMoRV+9ZB7VY9ORh79alHzdPdg4DrOXt+J9nrrl+u4FP1C1pBLLujPReKs7tRq/CnGf15BfzgG6V7ykFBAx2WXBK3Zg4nx4a9aS/sT1zZ+s=" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=debug msg="completed keyexchange" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22:15Z" level=debug msg="completed challenge" Nov 01 06:22:15 volumio go-librespot[15819]: time="2025-11-01T06:22: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 06:22:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:17 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:17 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Nov 01 06:22:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:18 volumio go-librespot[15840]: go-librespot daemon starting... Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=debug msg="app state loaded" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" 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 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" 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 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=info msg="zeroconf server listening on port 39105" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=debug msg="obtained new client token: AADZ4VAqKVg1oZVnBLYokjpb4vNG9oONbbOeurmYV1RVtM2/kBuk81xEw084R4C2gpWhj5mBpXernPhRL6piLCHka0a9KE66e5Ld2VK1HWNsrs8K1pKTCWmuGVE/b874OazW6oXPRwCUpdiO+oYAzMBcCEOd/jVyrXwP56xdrhXVfFvxvRO4BF1ZtIyneyhWoqJ9k6OvZLj+eaDnzUFuSI+e0965S+0c6HW50JibyWZiphAw+Fvu76Y=" Nov 01 06:22:18 volumio go-librespot[15841]: time="2025-11-01T06:22:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:19 volumio go-librespot[15841]: time="2025-11-01T06:22:19Z" level=debug msg="completed keyexchange" Nov 01 06:22:19 volumio go-librespot[15841]: time="2025-11-01T06:22:19Z" level=debug msg="completed challenge" Nov 01 06:22:19 volumio go-librespot[15841]: time="2025-11-01T06:22:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:20 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:20 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Nov 01 06:22:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:22 volumio go-librespot[15848]: go-librespot daemon starting... Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="app state loaded" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" 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 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" 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 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=info msg="zeroconf server listening on port 39523" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="obtained new client token: AABFjgV0LcahQCMdrT959wzbxaVzoHCnbIkvriQQFH2VTdIBDtWQw6kQWk1C99EVLIWGrDr2f9mLxEzKkJDtohSslu84xKczJ+cR4cWHHDV0uSvDW6mx/wwlcRulbiw/0328Jdt+KV29zJYNx2yuqECnYgATDu3/GsGIy8NrxrkWtxfCVoTLO2BR1C2dYZpUkOhi2p1BUpKUYLDTDDs4u6P38GAIDn24vzW80AV+untD96Pm24JJGWo=" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="completed keyexchange" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22:22Z" level=debug msg="completed challenge" Nov 01 06:22:22 volumio go-librespot[15849]: time="2025-11-01T06:22: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 06:22:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:23 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:22:23 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:23 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Nov 01 06:22:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:25 volumio go-librespot[15859]: go-librespot daemon starting... Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=debug msg="app state loaded" Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22: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 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22: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 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22: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 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=info msg="zeroconf server listening on port 40881" Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=debug msg="obtained new client token: AAAm5JnG7llOiwNDcS+Yeph82YIus6g3K2awzqLCkuFVHpUrThCjj6pA8W52uihjhZliody7bUMZySBy+Ci2VDEtgvwqy7wQc5Ga1LZ3FD0/ycMzxL2sApJOdMLcJMCsSlE4ol7Lqlyp4e4OhFtoUe83SnvdyJR+og1BRvP8bOjpf5CI/4q6z9/rOV7pO3sfk9m17s3LsUXn9N69nAtO9HlWXcKTyOIvRsryBQr0cP7svniwvvijS1A=" Nov 01 06:22:25 volumio go-librespot[15860]: time="2025-11-01T06:22:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:26 volumio go-librespot[15860]: time="2025-11-01T06:22:26Z" level=debug msg="completed keyexchange" Nov 01 06:22:26 volumio go-librespot[15860]: time="2025-11-01T06:22:26Z" level=debug msg="completed challenge" Nov 01 06:22:26 volumio go-librespot[15860]: time="2025-11-01T06:22:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:26 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:26 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Nov 01 06:22:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:29 volumio go-librespot[15883]: go-librespot daemon starting... Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="app state loaded" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=info msg="zeroconf server listening on port 34117" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="obtained new client token: AADWYdaJxxBXg/QMJkA9K5C2Et2PkKPgpc7svAF1+RKcmcmRfkG77c7iSM+8KJCTtQX+5FkXY9hOlhDKYPecRtSp0mx7c7N+CIrgg9u5G8//MNsoAn0EELr+uq1Gbbya9qoApQx/+Bl8vl1dZYmvbUlq04e+T63CB+CUXFkxTouRG0x5/coQm5cZ3G1fPKAtTFWKtjCwncqCEim/AQbZ+BUb9LmIHRj9jFhTo2VC7CtoP9RRJOnU6vc=" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="completed keyexchange" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22:29Z" level=debug msg="completed challenge" Nov 01 06:22:29 volumio go-librespot[15884]: time="2025-11-01T06:22: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 06:22:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:29 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:29 volumio volumio[14829]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125. Nov 01 06:22:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:22:32 volumio go-librespot[15891]: go-librespot daemon starting... Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="app state loaded" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:22:32 volumio volumio[14829]: info: Initializing connection to go-librespot Websocket Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="new websocket client" Nov 01 06:22:32 volumio volumio[14829]: info: Connection to go-librespot Websocket established Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" 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 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" 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 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=info msg="zeroconf server listening on port 33115" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="obtained new client token: AAB183b6PzS6UzkkBCPXXVYNNGuiaQOMDtrwbdO8mz+3/sILcxWoif3BLUiVhYQY5bo/AIfGAzLMUyt1OCN43fi5UB+7E4KHrYQU2sd0GTOMUkRFVxPBF0vF1yh1YHfdzQtgfeqvhmPjxzxE5fRtPAdlFnJ4C9HM6VCW+tfaYW1Wq2WRNQTAdd8LJr2bhO/GoS3XMFFaSKmP5ZpA+XE2wu5waeTYpDkcEQ/TEcCb98ePZupQdnIBzuI=" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="completed keyexchange" Nov 01 06:22:32 volumio go-librespot[15892]: time="2025-11-01T06:22:32Z" level=debug msg="completed challenge" Nov 01 06:22:33 volumio go-librespot[15892]: time="2025-11-01T06:22:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:22:33 volumio volumio[14829]: info: Connection to go-librespot Websocket closed Nov 01 06:22:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:22:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:22:35 volumio volumio[14829]: info: Getting Spotify volume Nov 01 06:22:35 volumio volumio[14829]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 06:22:35 volumio volumio[14829]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:22:35 volumio volumio[14829]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 01 06:22:35 volumio volumio[14829]: errno: -111, Nov 01 06:22:35 volumio volumio[14829]: code: 'ECONNREFUSED', Nov 01 06:22:35 volumio volumio[14829]: syscall: 'connect', Nov 01 06:22:35 volumio volumio[14829]: address: '127.0.0.1', Nov 01 06:22:35 volumio volumio[14829]: port: 9879, Nov 01 06:22:35 volumio volumio[14829]: response: undefined Nov 01 06:22:35 volumio volumio[14829]: } Nov 01 06:22:35 volumio volumio[14829]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 06:22:35 volumio sudo[15914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 06:21' Nov 01 06:22:35 volumio sudo[15914]: 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"