Nov 05 06:45:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 48. Nov 05 06:45:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:01 volumio go-librespot[15058]: go-librespot daemon starting... Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="app state loaded" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=info msg="zeroconf server listening on port 35559" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="obtained new client token: AABvhPGQgVemZUAHFCC4pizk2SyZd7dQWwXAurgAWYkxnCikpelI1uDBLNyS9nSp5T+Dql+O38/7+tJq8Yb6xu5ru3Vw3EBamEw3JVd14/jZUVVbjEBKcQglnkLpB1YmVUVDNCO2enUkLroA4NORYqt8PJb1slGmVLOm4mpITIzfC/6LIcBq0G8c+lbpw8i9AwwNJT3iq49OIZhEjDAbEg5ksr/LW45LRfEiHv7oT+f2Z8Fsw1+fUyI=" Nov 05 06:45:01 volumio go-librespot[15059]: time="2025-11-05T06:45:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:02 volumio go-librespot[15059]: time="2025-11-05T06:45:02Z" level=debug msg="completed keyexchange" Nov 05 06:45:02 volumio go-librespot[15059]: time="2025-11-05T06:45:02Z" level=debug msg="completed challenge" Nov 05 06:45:02 volumio go-librespot[15059]: time="2025-11-05T06:45: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 05 06:45:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:02 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:02 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:02 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:02 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:02 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:02 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 49. Nov 05 06:45:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:05 volumio go-librespot[15069]: go-librespot daemon starting... Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="app state loaded" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=info msg="zeroconf server listening on port 41889" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="obtained new client token: AADQ9PSc30/Y9zB47rhc0RMJ6xvtpN6mUqVp7c2eUkFJ9FetiqCG0grp6zDrLFDXaZQAJ4Fz0DOh+f1i8Iiij2KbM+tH+Qe0GAYC7WssP+37fSxDKihGZOOts28+6ZJCrjyIVIzlTx3qq/sjOVYbmC/5O0t1lqYG1QFCZOIbXvIZQoA5r6O8hg4vWdnT0muZqlQimVp9t7XKY89iqcC3yu3TrGGlJ2uNol9zts3j4VVKnI+H8Lm8rM4=" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="completed keyexchange" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45:05Z" level=debug msg="completed challenge" Nov 05 06:45:05 volumio go-librespot[15070]: time="2025-11-05T06:45: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 05 06:45:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:05 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:05 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:08 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:08 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 50. Nov 05 06:45:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:08 volumio go-librespot[15077]: go-librespot daemon starting... Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=debug msg="app state loaded" Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:08 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" 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 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" 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 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=info msg="zeroconf server listening on port 46809" Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=debug msg="obtained new client token: AABoJUnpVXvgxXPgwOnegK5H4gdXcZRBl5rC0Cpwb2P2xNCUkSsaXK9A4r7SnGAURLs4gfxXaNg3FSzgrBKCTmKrDacYa09ZKhu5pnE1j/AwZ892nTm2R6oPf8Q/hFoEQnMJdzh/Bd2y9pxQDzPKJTlI+TIlRkXVqBVET3sRUihFEMbLvmTJ+q0MAKFf8lSbkinIKcmXqZqIK/nFzPAkrLBqS23YD+u7G466kstfL+p4/PuYD/bkniU=" Nov 05 06:45:08 volumio go-librespot[15078]: time="2025-11-05T06:45:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:09 volumio go-librespot[15078]: time="2025-11-05T06:45:09Z" level=debug msg="completed keyexchange" Nov 05 06:45:09 volumio go-librespot[15078]: time="2025-11-05T06:45:09Z" level=debug msg="completed challenge" Nov 05 06:45:09 volumio go-librespot[15078]: time="2025-11-05T06:45: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 05 06:45:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:11 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:11 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51. Nov 05 06:45:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:12 volumio go-librespot[15099]: go-librespot daemon starting... Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="app state loaded" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=info msg="zeroconf server listening on port 44207" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="obtained new client token: AABwQ35z0f+YAgwzw6uSHw3W+2e7OR+nCMRqEugMeqdmJCtS2e+fZaPUAbZOnntD5D4XXi6R8c6l7LZRcQOPfRsxfs2mUrhNTzI0T7IKRT5ojriSYfvn3ENkARtgDTa7xoJ87Mne3vbEo3M38kau1gVyOrX6k3CjSBZEWmdG80maTBLmCowmNtWaKJy2Y3F+MDWtuKrfyc/rxdvhQUwfOuNqqoV829kxzRKKZT2WslRjGwrEH8SwnVM=" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="completed keyexchange" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45:12Z" level=debug msg="completed challenge" Nov 05 06:45:12 volumio go-librespot[15100]: time="2025-11-05T06:45: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 05 06:45:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:12 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:12 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:13 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 05 06:45:14 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:14 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Nov 05 06:45:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:15 volumio go-librespot[15107]: go-librespot daemon starting... Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="app state loaded" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=info msg="zeroconf server listening on port 35559" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="obtained new client token: AACu+YHCI+G0/lYNRoy3fpXPgum04ae9AgoFDAGQ8Xwg4b48mgX27ETYjyKw5sb3zIX0kbE220gKKWX9+6txPk4VCUvsWQENuCFRwzuHzReLTLu9CQRt5nZViGukUOlXB+coafFzGE+R19a8JXA8fhiuwQfCyUrIUmhjyTw+tfZn9fz/DqWPKcROoF4L+fcSezP0Mv+5nEAeisNkETzUdkZ8vpqObaYykYxmZQtkeYI9mWLPbjLIbcQ=" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="completed keyexchange" Nov 05 06:45:15 volumio go-librespot[15108]: time="2025-11-05T06:45:15Z" level=debug msg="completed challenge" Nov 05 06:45:16 volumio go-librespot[15108]: time="2025-11-05T06:45: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 05 06:45:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:17 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:17 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Nov 05 06:45:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:19 volumio go-librespot[15115]: go-librespot daemon starting... Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="app state loaded" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=info msg="zeroconf server listening on port 34463" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="obtained new client token: AAAOD3jd0KycnpW6IijZUlDvTHFBwLl67qV/i8GIQyaOs5Uw5IchK920FyaCGqEmV22UFmj8R1tn0ssTFlGoHUWUQsPK78ryTwGs1GM2FOEMXwR8rhxkRfNCckUcifbypxiuUsxaEOB3x4sYP8oGZedVaGWPxg+09VorAA3EcOydCL5ByU5AvgHZbOcAcIJhHVCuh+DANpKfgmwZD67NErEbi12bF8dXpvR06feFmIGwqMSQk75r/vc=" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="completed keyexchange" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45:19Z" level=debug msg="completed challenge" Nov 05 06:45:19 volumio go-librespot[15116]: time="2025-11-05T06:45: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 05 06:45:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:20 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:20 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Nov 05 06:45:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:22 volumio go-librespot[15138]: go-librespot daemon starting... Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=debug msg="app state loaded" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:22 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:22 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:22 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:22 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" 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 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" 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 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" 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 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=info msg="zeroconf server listening on port 44257" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=debug msg="obtained new client token: AAAV0aieLyFCfjTDqTp7r9KCTljlWu9OZiR+z3o9KnF3s7RZyrhnIZNakVVHotjm2iiSB/AjwY4pPKrp7GcS681M2wqbuPkmB4cuJgCIBsFIAZfNlOJw1NWcfHWmPHPO5raB/G0l8jJpVjV+gdnriOOJV5Dr/4qJ0Dtv6iaDlGJofRjp7vKjofTFFmqpM09lxzBoKWwYBtzIc4pNTDwqExjOFjW3lFfdgeqpIQZBPgwuuRvEiT4+ywE=" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=debug msg="completed keyexchange" Nov 05 06:45:22 volumio go-librespot[15139]: time="2025-11-05T06:45:22Z" level=debug msg="completed challenge" Nov 05 06:45:23 volumio go-librespot[15139]: time="2025-11-05T06:45: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 05 06:45:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:23 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:23 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Nov 05 06:45:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:26 volumio go-librespot[15150]: go-librespot daemon starting... Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=debug msg="app state loaded" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" 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 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" 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 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=info msg="zeroconf server listening on port 40495" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=debug msg="obtained new client token: AAAdG3KY3Xbtn4vsnBDP6X9rak4khPfOZPKT8EJ4gfwrF5FFNoQ0m7fM/g6lHLBzZPcgriT0SViYPv/hhs22dHWRexSWIxxo2Q58Ex468yQmSSPMnjWD2qBzVUpeoo9BfbtE3Qn28Jbgp83mkuqdGSJUHqCTzEnPjP53sst0O08so2WtBqFUBY5t4cpDtYQXdAzqXLATsKNExN5vL8VQYdSVK0Nq+fdlRhoCwW7mHKYWKqCRggZcf78=" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=debug msg="completed keyexchange" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45:26Z" level=debug msg="completed challenge" Nov 05 06:45:26 volumio go-librespot[15151]: time="2025-11-05T06:45: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 05 06:45:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:26 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:26 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:28 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 05 06:45:29 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:29 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Nov 05 06:45:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:29 volumio go-librespot[15172]: go-librespot daemon starting... Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="app state loaded" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=info msg="zeroconf server listening on port 41673" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="obtained new client token: AACV+48d1xXHQT7IWCZZZXONssbqtQfOkrMJjFAC0SKFR1HbaRkepGl4226zGsr7vVWDP6bpiYiTjCoRJ5byb1UwBqDPjYCflAAQS4Ohb0R73uhW8+TzMzitG+wJLu8wfhgqis1GAXV6SlT6HIf8eBw0yz4BJ5JxbeBgnuihFf3RNHOw80sm3hPZ8toIiQC8IU74y3WiQYlUOJXrrke6DRmDGNMUpUAJfrOTEBh1djRgKzDpy2iRGzo=" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="completed keyexchange" Nov 05 06:45:29 volumio go-librespot[15173]: time="2025-11-05T06:45:29Z" level=debug msg="completed challenge" Nov 05 06:45:30 volumio go-librespot[15173]: time="2025-11-05T06:45: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 05 06:45:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:32 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:32 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:32 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:32 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Nov 05 06:45:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:33 volumio go-librespot[15180]: go-librespot daemon starting... Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=debug msg="app state loaded" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" 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 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" 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 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=info msg="zeroconf server listening on port 33667" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=debug msg="obtained new client token: AABivFiDPllWsju3J11Hx3yuEg6X6ld6PUmt0lJ+ldFBXn5zYPPGNgluvHevVcv2qBQ5FAr7jBw5qnxEshn7HCeO1wD+kTuRx35+fYcC47AoyGJVSUXJfx41iUH7b8kHvsYgNMl6dvfTInqRLKsj1SAaGyGeNnqiI4STI4WbKRTWCclet5OFDyfGAJbG27aNOFzJ88KP54IFYC5T5AbWCPOgXG17J6kqeVL2gQQUyhS/P3VzCfOhD0w=" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=debug msg="completed keyexchange" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45:33Z" level=debug msg="completed challenge" Nov 05 06:45:33 volumio go-librespot[15181]: time="2025-11-05T06:45: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 05 06:45:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:35 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:35 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Nov 05 06:45:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:36 volumio go-librespot[15188]: go-librespot daemon starting... Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="app state loaded" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=info msg="zeroconf server listening on port 36339" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="obtained new client token: AADiVYLQ2SBRwQC9jpplUA2UREEzU+xmyXPtUlqPlLL7sigdxe++FwJ6p0iRB0HtSY8eNjxvbd8kDqnP8QgYupIGG6Y19IVE1I0+w/hM8/1ihnrFl7Z1kHcoroK6KiOTKQPxT4G0Oqgh2aL+K1D7hjWeARuYZ+2ZzOl8bJqyHaBEpKLAfsEeo5yvqcMQTkDO84yxA1idXz56jRAZClCZiob+9RFPVU76z+3RCp+zElI941vaSJ/HvLg=" Nov 05 06:45:36 volumio go-librespot[15189]: time="2025-11-05T06:45:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:37 volumio go-librespot[15189]: time="2025-11-05T06:45:37Z" level=debug msg="completed keyexchange" Nov 05 06:45:37 volumio go-librespot[15189]: time="2025-11-05T06:45:37Z" level=debug msg="completed challenge" Nov 05 06:45:37 volumio go-librespot[15189]: time="2025-11-05T06:45: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 05 06:45:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:38 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:38 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Nov 05 06:45:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:40 volumio go-librespot[15211]: go-librespot daemon starting... Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=debug msg="app state loaded" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" 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 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" 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 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=info msg="zeroconf server listening on port 32989" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=debug msg="obtained new client token: AADkUiU0AUoVvpJwrbC+23m2v6ljmut+o2YWqb9mGL6c6TOsqmNevesPS/ZyEGuIWm9XQqQiokFd+2QyThxPVJ6KC/6z9+lPHN+KlQOOguxtw9Vk348vSbVCIJAGfkmTjfHuld1E78fozBXBRzb7Uk+uDcH9OOQBKHDmWMWIlXpsfhEWTCWj5qL37ZY4bOulaOCfzJeC/urJuJYztNXnh2hLv+nnbzEc1308Dj+RWy3Tqm2q/HbzsM4=" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=debug msg="completed keyexchange" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45:40Z" level=debug msg="completed challenge" Nov 05 06:45:40 volumio go-librespot[15212]: time="2025-11-05T06:45: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 05 06:45:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:41 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:41 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:42 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:42 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:42 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:42 volumio volumio[14437]: info: Listing playlists Nov 05 06:45:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Nov 05 06:45:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:43 volumio go-librespot[15220]: go-librespot daemon starting... Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=debug msg="app state loaded" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45: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-gae2.spotify.com:80]" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" 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 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" 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 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=info msg="zeroconf server listening on port 44379" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=debug msg="obtained new client token: AABUgzqX90ZEQTGvLb5RgCPbdVKVn3oUlevE5R6SIx6YiOrzSd0Tvmq4l2FNoHiorCD5u6aoMQmCSHhzdk50whOPA8+GlcHewmm0fVYN7yDZMfSIwFGlDBzZWjqjf6gZeAiAhKQaiJhKqtV/2OqjMKqqgWqYQedcC9lKZ0GpSOb1lny6Tckv1YNSQmQPn7k8rX7GAJVYWPg+3vnThL3wnvCpmNAA25nNXBsfGQrwNIYUZBgAd39k7bo=" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=debug msg="completed keyexchange" Nov 05 06:45:43 volumio go-librespot[15221]: time="2025-11-05T06:45:43Z" level=debug msg="completed challenge" Nov 05 06:45:44 volumio go-librespot[15221]: time="2025-11-05T06:45: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 05 06:45:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:44 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:44 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Nov 05 06:45:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:47 volumio go-librespot[15231]: go-librespot daemon starting... Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=debug msg="app state loaded" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45: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-gew4.spotify.com:80]" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" 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 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" 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 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=info msg="zeroconf server listening on port 33305" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=debug msg="obtained new client token: AABxZbCwuWdn9n4QTcCJPjePYDQ70YpTORv++5EWdcSGMa328nPA1yem0wDN0jSIPtlbPoTwii4BPTkmSkvuIGa2uYj0ENMgI7fKsX7aohPggOPki72cuI9kXM593KSkgHKT7X23Gjb1hgnLAeCKh+H+caMPDWW8l+E+D7EVY8jbmi1O9GvR+BQNj4itXJkthbwkVyLA2b2FcLxdCqCLJEZKfdenJY71sKjoGpF2OVuJ6d2WZLWCqhQ=" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=debug msg="completed keyexchange" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45:47Z" level=debug msg="completed challenge" Nov 05 06:45:47 volumio go-librespot[15232]: time="2025-11-05T06:45: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 05 06:45:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:47 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:47 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:50 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:50 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Nov 05 06:45:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:50 volumio go-librespot[15253]: go-librespot daemon starting... Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=debug msg="app state loaded" Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45: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 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45: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 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45: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 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=info msg="zeroconf server listening on port 40367" Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=debug msg="obtained new client token: AADcXbJqGFrX6x7IWPhR9QXSanfcUpbW7xt9Tst0qOnirIZRAK/bV6FuKiSDMBg23/fSlC8DmnLD3CI9xVPGBviJcxCR+a4voiAx8vVpgGYfGciCkzElds9KWlE7jz1Fqa99oDxZd5S1tOAo0EyZsbQkPRStO2tekeiC6HL19wxhbFRwsCe6+wGEhP2Wd+Q4MI5mGow+LEU0tEml16pJIIAyPe150Q6EpltptuxhKDkrB7hypC1ROd0=" Nov 05 06:45:50 volumio go-librespot[15254]: time="2025-11-05T06:45:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:51 volumio go-librespot[15254]: time="2025-11-05T06:45:51Z" level=debug msg="completed keyexchange" Nov 05 06:45:51 volumio go-librespot[15254]: time="2025-11-05T06:45:51Z" level=debug msg="completed challenge" Nov 05 06:45:51 volumio go-librespot[15254]: time="2025-11-05T06:45: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 05 06:45:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:52 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:45:52 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:45:53 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:53 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 05 06:45:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:54 volumio go-librespot[15263]: go-librespot daemon starting... Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=debug msg="app state loaded" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" 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 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" 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 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=info msg="zeroconf server listening on port 34237" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=debug msg="obtained new client token: AABBLVYlT2lYA4ouXvG4nCayWlu9Z34+XU5Ws+DK0fgppatf5Pt/mkvuQCQ4y46RE4HAl0baukbdhQjkcfhP8ZmqowvNXee9RVhCelXlMlhtnZiW6WaMv/DyqFJabAxLo9ol13fq+FPjBw1TsQOQGybqn9QpHtiyGU7NAZxRF29uPkP6PsiKOoDXi45zwj6Gqg+KdAXW0YuCD59sHLinyfCaDcjcsvl5mRYajSyvzgMacWAbHMuiyYY=" Nov 05 06:45:54 volumio go-librespot[15264]: time="2025-11-05T06:45:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:55 volumio go-librespot[15264]: time="2025-11-05T06:45:55Z" level=debug msg="completed keyexchange" Nov 05 06:45:55 volumio go-librespot[15264]: time="2025-11-05T06:45:55Z" level=debug msg="completed challenge" Nov 05 06:45:55 volumio go-librespot[15264]: time="2025-11-05T06:45:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 06:45:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:56 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 05 06:45:56 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:56 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 05 06:45:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:45:58 volumio go-librespot[15271]: go-librespot daemon starting... Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=debug msg="app state loaded" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" 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 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" 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 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" 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 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=info msg="zeroconf server listening on port 43321" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=debug msg="obtained new client token: AADWJD8sLz/3BDjWZYVr1qM8ekpXORoxclcCi8g1e1n4jnfiMXT5JzhLfG392hmdRXIYycRGW1Ej9ct/U02A78BfFWKaRkus8cMKwbHMAZ4I7YcNxC6iQeJCZQ84NwTrIGSI/+glSR1NVE0ExnOyTsJ4W568DWv7ObbNNEvwdXHk4QQOw1OmqInK0b1Yp/YgMVevfVEpIxItPhk+0wdvomsZpYEJkOEN58EiYQfCYHJtmGkCpdvuhyE=" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=debug msg="completed keyexchange" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45:58Z" level=debug msg="completed challenge" Nov 05 06:45:58 volumio go-librespot[15272]: time="2025-11-05T06:45: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 05 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:45:59 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:45:59 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 05 06:46:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:46:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:46:02 volumio go-librespot[15294]: go-librespot daemon starting... Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=debug msg="app state loaded" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" 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 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" 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 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" 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 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=info msg="zeroconf server listening on port 39559" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=debug msg="obtained new client token: AADomMQbn88EbYHUp99MeiBYGagIqfiB1R7lAiZeEhTHpajv6PhUzXB4XqRXZGim8v38US6Yp9cNUH+UJLJoJHIgD4gDLBkA5ryQWgFlBnJ9JrZPjB46JX+z7VN6gWxqq44byjBWeM+bb5ZvIWyfys8ne6IyVJlGCvQ43h3d7zzRAAuh0GU1+WCVpj2jGPtBwsiQmLU3MNrBQ2H2BVg4Hq0ISEYsPEcu+6M6t/sx0rS49uy6xG5+" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=debug msg="completed keyexchange" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46:02Z" level=debug msg="completed challenge" Nov 05 06:46:02 volumio go-librespot[15295]: time="2025-11-05T06:46: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 05 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:46:02 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:46:02 volumio volumio[14437]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:46:02 volumio volumio[14437]: info: CoreCommandRouter::volumioGetState Nov 05 06:46:02 volumio volumio[14437]: info: CorePlayQueue::getTrack 0 Nov 05 06:46:02 volumio volumio[14437]: info: Listing playlists Nov 05 06:46:02 volumio volumio[14437]: info: Listing playlists Nov 05 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 05 06:46:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:46:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 06:46:05 volumio go-librespot[15305]: go-librespot daemon starting... Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=info msg="running go-librespot 0.4.0" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="app state loaded" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=info msg="zeroconf server listening on port 43645" Nov 05 06:46:05 volumio volumio[14437]: info: Initializing connection to go-librespot Websocket Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="new websocket client" Nov 05 06:46:05 volumio volumio[14437]: info: Connection to go-librespot Websocket established Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="obtained new client token: AAARs4wsWY/TO7e/jfflr5gLbWo02ZjWC3sS16sOCd0G2TPWxbXJNwBhxAUyGEKCbTEILb/vM71kCNAjw+GjqopYE3ppOA4UNa0i2zyIfItcPGpZIV38xMnm4s9GXlcYejKIBUuj43dsuvtwnJfuodeHeQsswXaIt93NIZu/Wm9C4ChwAV5xUngkTyEznoVEhJFYM08LLorexuiERySsm1yMGMfpD+mpfMDAPUYBQqjI35I1SjjvNFA=" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="completed keyexchange" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46:05Z" level=debug msg="completed challenge" Nov 05 06:46:05 volumio go-librespot[15306]: time="2025-11-05T06:46: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 05 06:46:05 volumio volumio[14437]: info: Connection to go-librespot Websocket closed Nov 05 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 06:46:08 volumio volumio[14437]: info: Getting Spotify volume Nov 05 06:46:08 volumio volumio[14437]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 06:46:08 volumio volumio[14437]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 06:46:08 volumio volumio[14437]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 05 06:46:08 volumio volumio[14437]: errno: -111, Nov 05 06:46:08 volumio volumio[14437]: code: 'ECONNREFUSED', Nov 05 06:46:08 volumio volumio[14437]: syscall: 'connect', Nov 05 06:46:08 volumio volumio[14437]: address: '127.0.0.1', Nov 05 06:46:08 volumio volumio[14437]: port: 9879, Nov 05 06:46:08 volumio volumio[14437]: response: undefined Nov 05 06:46:08 volumio volumio[14437]: } Nov 05 06:46:08 volumio volumio[14437]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 06:46:08 volumio sudo[15327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-05 06:45' Nov 05 06:46:08 volumio sudo[15327]: 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"