Nov 04 14:53:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Nov 04 14:53:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:00 volumio go-librespot[11283]: go-librespot daemon starting... Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=debug msg="app state loaded" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" 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 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" 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 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" 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 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=info msg="zeroconf server listening on port 43349" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=debug msg="obtained new client token: AAA8boDJLqvMlD8tFsJdg0sarxdGNdGAaEU8nDxCshz8wLdLLjbwuRXerySc8ykAj1MiMaTmEw4BbwZFXdyQ0nvJe0DkKhQzd2kplFht7/FcB/8+Q/LI1300FviA2HE9Q+snc2oSrkFLxb9DgxZlKZLASj19zCiy/0QvFhoCmqw2Ez3NUf/qyvo97BxLFNw+8D+3FCPZIEhrWJ0l9m4Q6b/FDs4kglTSB7h8YGuajxwPyffv8kAm" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=debug msg="completed keyexchange" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=debug msg="completed challenge" Nov 04 14:53:00 volumio go-librespot[11284]: time="2025-11-04T14:53:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:01 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:01 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Nov 04 14:53:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:03 volumio go-librespot[11292]: go-librespot daemon starting... Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="app state loaded" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=info msg="zeroconf server listening on port 43931" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="obtained new client token: AAA2x3A1BpMAYT3HIx6871dkPvrVtgL9f1QUHVDAMWe9rVOfgXmzw5A9ywu61PcZWNhr5+vVAiAf1+VBXRj2DMfUjYksMQDDeBYKjlV/yyONQrZ+3sDWJtMLMBHGfvAo52nJccm7kTup6xPKAdag2EsPEYvnL+ihXu4wgCmhxp+YMFptwjoM8BW3lXvvzm/d/LlVhZ/TX6YwOs98c8KtK1M+j8avAlnZwabriZZ8mnL48Ultykf+tgo=" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="completed keyexchange" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=debug msg="completed challenge" Nov 04 14:53:03 volumio go-librespot[11293]: time="2025-11-04T14:53:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:04 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:04 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:06 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:06 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Nov 04 14:53:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:07 volumio go-librespot[11314]: go-librespot daemon starting... Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="app state loaded" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" 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 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" 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 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=info msg="zeroconf server listening on port 39257" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="obtained new client token: AABcd3Tn1D4YSfEmZjIH1AcX8gQ5VuSkNc1ys3dO+ZXJW6mf04pZhdDrELShzmWBGHqMA4ao9VdMzLv33XNgrzIo7QpN901omHuSBiZTbdEFjxJpKMt0P+7jBsjwpGrygMIK4EV24sPm+CQvXli4VQglZwiy6ZwUyx3jlTWNy8VVIVVeXFSDpP35tfEx4BLCKUsw3RCIeA+fydBmWcqz+74lLZgjotylegdXwQFISlIgC/cXx+pP" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="completed keyexchange" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=debug msg="completed challenge" Nov 04 14:53:07 volumio go-librespot[11315]: time="2025-11-04T14:53:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:07 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:07 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Nov 04 14:53:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:10 volumio go-librespot[11322]: go-librespot daemon starting... Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="app state loaded" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=info msg="zeroconf server listening on port 42619" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="obtained new client token: AACWL2Umuy0Z508Duu0bxCJUQ7s0e+qbAJjHtxM7usn119kAdKVgGfLMIZyVdrFT0/fiqbyIV0lltfVgCPq5IgA9UKaxz6H9ZYAdPJQOYjro8KqoaEXZfeISkQ+HK3rblxaBGRahYhdVs4wKN9AjOwtO9p94bpk7Fvt+z+zsb3PwD9uFwqh9P38U8isdSk12Ypd0gf0aDv7peNMDxBZwqoZW7/0FvcoSQ4cwgcFwXrbg/3qqW563arY=" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="completed keyexchange" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=debug msg="completed challenge" Nov 04 14:53:10 volumio go-librespot[11323]: time="2025-11-04T14:53:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:10 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:10 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:13 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:13 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Nov 04 14:53:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:14 volumio go-librespot[11333]: go-librespot daemon starting... Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="app state loaded" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=info msg="zeroconf server listening on port 37951" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="obtained new client token: AAAAzHH/CTharKe8WUC4hsZqnrhyF39WmxpGZ+hUqf7Fi4DYE9b8hWYHuTze6G+XELtc4r3NbYIxO9LsgoevQDU4jE+yyUnfj5KqdZtxxOfeemOCqhy8BNk/p5jlJ+PnHXYmo+040lfVgXV1rmSmzSfI4sATW444BjUnPree2ey3PO+lH/QDd+xIObVkRESm7DLgt3YAIwAXpxAnrM+nV0t9aLyKb0PyKPNcFwaggOFIsADFaQvJ" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="completed keyexchange" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=debug msg="completed challenge" Nov 04 14:53:14 volumio go-librespot[11334]: time="2025-11-04T14:53:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:16 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:16 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:16 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:16 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:16 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:16 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Nov 04 14:53:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:17 volumio go-librespot[11356]: go-librespot daemon starting... Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="app state loaded" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=info msg="zeroconf server listening on port 39639" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="obtained new client token: AABBFGpMjFSJShX4ToghFcL3WPS7/kYVEku7X0m/Q0cmUptzj9qKyF6vIr0DVXnp9aezpHfqayxifwUvGRZcM3yWD/tNWV/9ALryTgKwIkL1sjrAtpsdV31XUvfQKMpFEvg1zBwJNW/lposT8B/vGTW+HzVr2tqvcRC5HtyqZR/FjxPcxWrJgFmpBtcNywYi7dSpVrm51OHnLXilteuNItnEBdqmvvgLkHtS3UYYDknyKeRJi3GFc7Q=" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="completed keyexchange" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=debug msg="completed challenge" Nov 04 14:53:17 volumio go-librespot[11357]: time="2025-11-04T14:53:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:19 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:19 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Nov 04 14:53:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:21 volumio go-librespot[11365]: go-librespot daemon starting... Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="app state loaded" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=info msg="zeroconf server listening on port 43595" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="obtained new client token: AAD0GqZr9RlJ4SMj7gkZYYAhPcTVwsl6uXrgtXo1tP7pKrLxLtPT/ruejqWVV0Fl31myu1n1966LX+Y3inBWDLIvDe3JwgyoaxLOllKlq/iiTvjhDT0YmIM2GniUdskhXDD+H//eSlj8FxT/VoqUFECVvcMKkKk8Ocnd1OJdYI3LOAhgG2HeTRCzIHm9EXgjz5LiUcvBZY6GNyOerWDiU/OskllGHKLVEn2odcyCU0npskQCQrSB" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="completed keyexchange" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=debug msg="completed challenge" Nov 04 14:53:21 volumio go-librespot[11366]: time="2025-11-04T14:53:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:22 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:22 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Nov 04 14:53:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:24 volumio go-librespot[11373]: go-librespot daemon starting... Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="app state loaded" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=info msg="zeroconf server listening on port 35223" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="obtained new client token: AACVZDtQpqMauM6NUMrKxAqFt7tespGhO5ABKbJph9iuRhzP/nHU27EwyxzWEWTEHJGH0wnR8s9FP49RwOy1q9QalE0W93Y6IKRE39wYYaxEaZFPUCVPOviR7PN7P1+ibXNSgO/0/mMccP7E3UzaWvWbDL/fgRNJpqWMFKyF9KylB5Y4ZiaZzoNDCQAJJ6Pc/QfqQcvBG8yl+pq051KeuaH1YzyOxXtUZVRTlXVurC2SnEWa5zj9o3g=" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="completed keyexchange" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=debug msg="completed challenge" Nov 04 14:53:24 volumio go-librespot[11374]: time="2025-11-04T14:53:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:25 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:25 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:26 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:26 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Nov 04 14:53:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:28 volumio go-librespot[11395]: go-librespot daemon starting... Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="app state loaded" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=info msg="zeroconf server listening on port 36845" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="obtained new client token: AACXoJZeGM4SO+w16P59SJY7dMKe5+ev0fQtHEQXnwMrXBRq/mIUbS1ih0LyOfwd4RrcF/X3tSM4KWX6xmen3jau0zhRH9v+x3DzbLP/NecNtwbMJ5w73VQlNkTn1FjaI6gZlxPShEpwPOVexaZq5YD4fA1sFTl8J7tNWjMrB03SE9T3RirQDfyqecK1N/r4pj4xkLxjPz46AmcF8BHNSczEj+QCkGLSU3XPNROUdAWpMZpvZYHU" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="completed keyexchange" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=debug msg="completed challenge" Nov 04 14:53:28 volumio go-librespot[11396]: time="2025-11-04T14:53:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:28 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:28 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Nov 04 14:53:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:31 volumio go-librespot[11406]: go-librespot daemon starting... Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="app state loaded" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=info msg="zeroconf server listening on port 36185" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="obtained new client token: AABVHCtm+yapKxuvX5vUlSmO2Ohhcec4vE0zz03fYIH0Z2Ba6Pfrnba5MqaX1BUIbdoSQRUU1IEQed6yD44XDeQDB3mu1276aBoOcqIFy0QiX4fj707TwC7COpfIJ0aEnM6gL1XrAAZlaHXUCnTJGref03eJVCUVOj3qV9F6AAb0EIiRMUP0zpHiZv2CrD5t/jv2zqwZxY9dOC/ol+DT3+z4nCUAgm5/JQIAX7eSyfXn39dUTUSH3G0=" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="completed keyexchange" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=debug msg="completed challenge" Nov 04 14:53:31 volumio go-librespot[11407]: time="2025-11-04T14:53:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:31 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:31 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:34 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:34 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Nov 04 14:53:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:35 volumio go-librespot[11415]: go-librespot daemon starting... Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="app state loaded" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=info msg="zeroconf server listening on port 46293" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="obtained new client token: AABk28yaNR0vkTMUxtHh8mQM/0gIROI4X/8uN9qBqHCAtE0VRQ0o6NVt8gGDQbj+uN/UZuXLt4E8TOG4MCrwrBOluKzEXLmXaUExf2ZDDyKOnJxHFWYfquEpXrvbXyx5qA6zPWXOeY9YMwOLrtj1wZJ2mDJwdgtbU+ezX1nJW24osGIS3JD9VgwgiYecAoktxSyEdo+u4XYre7hye1ll/AxaJsF62iDUIXs2/DulB+Gowe4zfdIY" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="completed keyexchange" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=debug msg="completed challenge" Nov 04 14:53:35 volumio go-librespot[11416]: time="2025-11-04T14:53:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:36 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:36 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:36 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:36 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:37 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:37 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 04 14:53:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:38 volumio go-librespot[11438]: go-librespot daemon starting... Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="app state loaded" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=info msg="zeroconf server listening on port 41825" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="obtained new client token: AADNHv9Kk9u03qUkoWCYEf9Gpaqy0pzMBAAm4kPYZEn8MP1HIJI9byUCuDsD1InQF7EXnQNKCaDshS3otkpGiD2IEVRn1Up+qQbcA6ZDoIjT1j66yM1RTOMWtm9yWJWKxF+dKuaUYBUjn4nmokkfayvpqg2A/NbuKqVrWGwj3RLd5legkK3jLg0Vrlj3uxcWQ+p1q57uu8HJhQdzsxsUcPrPvyRMhPVwZAwX1SgUX020wAyFMxBuyd0=" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="completed keyexchange" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=debug msg="completed challenge" Nov 04 14:53:38 volumio go-librespot[11439]: time="2025-11-04T14:53:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:40 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:40 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 04 14:53:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:42 volumio go-librespot[11447]: go-librespot daemon starting... Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="app state loaded" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" 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 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" 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 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=info msg="zeroconf server listening on port 42795" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="obtained new client token: AAAL4iscUPvRHkpDAWPztiVWJiSnptm5UXWL+w0YqY1bz8/tdUNrvvo4NwgbzDj1keLXijasTJ3Vd+6wCC7hkeUsvefIUYNJGqvJiQsew8i5EhdCx3Ymm+o9YEJ6+3xgb86GhVNaPLXvztnEt8zHUMdy1BiHEMYw7d9OYF7TwWSxydO278/uVs/69baOMq4SOClepmHMywsX0jXtXdZ6dPWW+hmVqM9h+TRxLmsOgJ8MJzue8EWF" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="completed keyexchange" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=debug msg="completed challenge" Nov 04 14:53:42 volumio go-librespot[11448]: time="2025-11-04T14:53:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:43 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:43 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 04 14:53:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:45 volumio go-librespot[11469]: go-librespot daemon starting... Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=debug msg="app state loaded" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" 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 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" 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 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" 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 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=info msg="zeroconf server listening on port 42147" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=debug msg="obtained new client token: AACOJ3/xKMzmdpE3ZLUyogxes8E0ZjWBs7/ogbdmzVs1h0ZRYazsukheundVg7+uDR2dWbP1Y31yJgVhm0oLfX4FYrjQO9X9fBhTQ+zz4ECKDr81NGTtS8FTl5qMUtmZOh3bWg684Bo45g/53GH3ToJ3nPS4+BllCPy0WKCitfgzVeQUCtuSS5fQ4d16m3M2tPI/f92Vsjk6sYFUmVd5SH5aLWQm1D3TuAqD8coBz0U9M9Mi7moc2ic=" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=debug msg="completed keyexchange" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=debug msg="completed challenge" Nov 04 14:53:45 volumio go-librespot[11470]: time="2025-11-04T14:53:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:46 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:46 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:46 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:46 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 04 14:53:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:49 volumio go-librespot[11478]: go-librespot daemon starting... Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=debug msg="app state loaded" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" 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 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" 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 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" 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 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=info msg="zeroconf server listening on port 35485" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=debug msg="obtained new client token: AAAaoFkAsszPoiC+/KG0hXgI3EPfGLDeU8V+CK6JlWXjt6Qw8lXDqAnDdW9jII9FtXysezJBFcKCJB4YP5x/u1pW9aDbHNdQj+TMB4m0CPFyJqcs7HOkldhHIbYp8pnDVr2afA155YTJG6bLxeGrIyfdHt/mWNHEbdlpWylmJZvRKHxxuCzCXs99mbj+cpsetX5vozKWfia43WdmldK/5x+Z+dSiK5AzRZKAdaDD3AKWDF8I3hzl" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=debug msg="completed keyexchange" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=debug msg="completed challenge" Nov 04 14:53:49 volumio go-librespot[11479]: time="2025-11-04T14:53:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:49 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:49 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Nov 04 14:53:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:52 volumio go-librespot[11489]: go-librespot daemon starting... Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="app state loaded" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" 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 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" 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 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=info msg="zeroconf server listening on port 42615" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="obtained new client token: AAA6aeDNhmyEFzsPDhsYTu46xHG+aQBMBcoucKQQxrpL6OOtZF6EKYBkoi3Y9OIODA4M7JhCm/kac4dQ0BUJ4/tnu+AYelRUN7w3BS2zozXYBkyCAFeM+JONcchBPvf8ybCIyXlxcBGIzmm/tV4qsgIur51TAayQvuzwomvbFBjbBh6jOedF9uz+xpFeTiuaIoi7HOTkpi13fmIVePdJ+OlkGM8l43Ur+VK6b2WYrroh5UOt+/8CmLU=" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="completed keyexchange" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=debug msg="completed challenge" Nov 04 14:53:52 volumio go-librespot[11490]: time="2025-11-04T14:53:52Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:52 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:52 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:55 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:55 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Nov 04 14:53:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:56 volumio go-librespot[11512]: go-librespot daemon starting... Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="app state loaded" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" 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 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" 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 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=info msg="zeroconf server listening on port 35963" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="obtained new client token: AAC1ZNJNH7wMZKBu1ry7eWDtnBV+U9OOX+k2tEyAx89fNF9OGvYtMPxVlka+lNhBN+ldSPrpfyKIQLhaxge6jIEk+9917IXowSDNRmysQI9xQ7yMjQUOzbq3L9T1de3Gw59FKPn0nUwTb4V/KXY9CDnA8vBxq2pBm/xvEUry1bU5OnrrK+0akW8+JqQPaych/2EoT5JnRTWPw699X3w6yRzc8PIgQxBQezkTLR7A6g+w3z+QWWN8" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="completed keyexchange" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=debug msg="completed challenge" Nov 04 14:53:56 volumio go-librespot[11513]: time="2025-11-04T14:53:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:53:56 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:53:56 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:53:56 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:56 volumio volumio[10765]: info: Listing playlists Nov 04 14:53:58 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:53:58 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:53:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Nov 04 14:53:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:53:59 volumio go-librespot[11521]: go-librespot daemon starting... Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=debug msg="app state loaded" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" 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 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" 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 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" 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 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=info msg="zeroconf server listening on port 42473" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=debug msg="obtained new client token: AADo1UqT2y7FooXqD4vZIdwQ2z9D3xIifN1fmCi6+U8wHSBdBPIfyRCmA9RmuQ1R1wzZscZdu5lm2DUOMXR8ZooV92JguEGi5/e3DNl8P1KXANJb7d+kiRkEeF0tuIXQXGupVFc9NjKJQU1yd+9LTj0oGtWPyf8ry7vyZz5tYheECJ1ExEgi3PpxDMZAArFmwbi1/xHxFVsTRXHSaC3wSDtpqMfMU5RHsgIMGXy6nwYYou2aRE92mmI=" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=debug msg="completed keyexchange" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=debug msg="completed challenge" Nov 04 14:53:59 volumio go-librespot[11522]: time="2025-11-04T14:53:59Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:53:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:53:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:54:01 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:54:01 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:54:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Nov 04 14:54:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:54:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:54:03 volumio go-librespot[11529]: go-librespot daemon starting... Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="app state loaded" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=info msg="zeroconf server listening on port 43105" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="obtained new client token: AAB7fXBbjXH2g0DFVCLDuGeG2EkCIwPS6dP7QaVGGAXc0c7rk4vI81AEs6JHW8yc4Mr6Rms+kSPNDGzTZ/rPAiHb+pHiv4IXDTcaVBxCIElYN01h475GcBBvlaGFbVwUdw9P/aNjWjIUWBBFX7EigvK5QebnxAA3dU9yMt+4PEylMltpWDNekNn/7Q+UwJTjwAaeLAsieYKZdbG4bKvPaTF4QxwN+n6JuO+JA3iNE7dYclytSGE3" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="completed keyexchange" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=debug msg="completed challenge" Nov 04 14:54:03 volumio go-librespot[11530]: time="2025-11-04T14:54:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 04 14:54:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:54:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:54:04 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:54:04 volumio volumio[10765]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:54:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Nov 04 14:54:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:54:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 04 14:54:06 volumio go-librespot[11551]: go-librespot daemon starting... Nov 04 14:54:06 volumio go-librespot[11552]: time="2025-11-04T14:54:06Z" level=info msg="running go-librespot 0.4.0" Nov 04 14:54:06 volumio go-librespot[11552]: time="2025-11-04T14:54:06Z" level=debug msg="app state loaded" Nov 04 14:54:06 volumio go-librespot[11552]: time="2025-11-04T14:54:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 04 14:54:06 volumio volumio[10765]: info: CoreCommandRouter::volumioGetState Nov 04 14:54:06 volumio volumio[10765]: info: CorePlayQueue::getTrack 0 Nov 04 14:54:07 volumio volumio[10765]: info: Initializing connection to go-librespot Websocket Nov 04 14:54:07 volumio go-librespot[11552]: time="2025-11-04T14:54:07Z" level=debug msg="new websocket client" Nov 04 14:54:07 volumio volumio[10765]: info: Connection to go-librespot Websocket established Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" 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 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" 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 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" 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 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" level=info msg="zeroconf server listening on port 42595" Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" level=debug msg="obtained new client token: AACpzoKY7CIuobQ3Ew8mhGKFVwE2x04pFsEVDDdbPx4CxdECAE5C12grzsf9av/1gQ0WZn+I0xLNEx0dTSiMBR0O2IcsiF1BfponSIMUIoP/mB4xbxxZMzelgjw3s/cK5MidmaEoF3lPYtUn16eqhoEmTg48JLpX8cVr0FZv0flIRw/aYzhuhBcbtSKMH8RPP37QNmpcuiaeAV8zWgeMMVhMZPNtHqMMGgwFB5lcriVp69kaQgUfPU0=" Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" level=debug msg="completed keyexchange" Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54:09Z" level=debug msg="completed challenge" Nov 04 14:54:09 volumio go-librespot[11552]: time="2025-11-04T14:54: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 04 14:54:09 volumio volumio[10765]: info: Connection to go-librespot Websocket closed Nov 04 14:54:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 04 14:54:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 04 14:54:10 volumio volumio[10765]: info: Getting Spotify volume Nov 04 14:54:10 volumio volumio[10765]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 14:54:10 volumio volumio[10765]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 04 14:54:10 volumio volumio[10765]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 04 14:54:10 volumio volumio[10765]: errno: -111, Nov 04 14:54:10 volumio volumio[10765]: code: 'ECONNREFUSED', Nov 04 14:54:10 volumio volumio[10765]: syscall: 'connect', Nov 04 14:54:10 volumio volumio[10765]: address: '127.0.0.1', Nov 04 14:54:10 volumio volumio[10765]: port: 9879, Nov 04 14:54:10 volumio volumio[10765]: response: undefined Nov 04 14:54:10 volumio volumio[10765]: } Nov 04 14:54:10 volumio volumio[10765]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 14:54:11 volumio sudo[11577]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-04 14:53' Nov 04 14:54:11 volumio sudo[11577]: 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"