Nov 01 08:08:00 volumio go-librespot[17306]: time="2025-11-01T08:08:00Z" level=debug msg="completed keyexchange" Nov 01 08:08:00 volumio go-librespot[17306]: time="2025-11-01T08:08:00Z" level=debug msg="completed challenge" Nov 01 08:08:00 volumio go-librespot[17306]: time="2025-11-01T08:08:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 08:08:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:01 volumio volumio[16875]: info: BOOT COMPLETED Nov 01 08:08:01 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:01 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:01 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 132. Nov 01 08:08:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:03 volumio go-librespot[17328]: go-librespot daemon starting... Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="app state loaded" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=info msg="zeroconf server listening on port 33935" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="obtained new client token: AABIe+m9x3gQjQZvnksmkv1vfGQc4yDfJLlca352EYBp3LGUH6WWH9zJSMF3iOIhkoAaksoupQTT/qaVnhewZO8s2WB09z2xMDvaXJW03auolYeaUGkskGrOa/ZpSS/+K/iY3SHmz2MH3ODSgVf9i0+hIudz5XaBMc+1Jncv0lsXPxkp5mtJo4Ss7+wG9ejgfkfr8Eqv9U/fUXhZ+jOG6OoWaQjLgLE387Pk9ioHHamPbFdhHoKmkYc=" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="completed keyexchange" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08:03Z" level=debug msg="completed challenge" Nov 01 08:08:03 volumio go-librespot[17329]: time="2025-11-01T08:08: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 01 08:08:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:04 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:04 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 133. Nov 01 08:08:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:06 volumio go-librespot[17336]: go-librespot daemon starting... Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="app state loaded" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=info msg="zeroconf server listening on port 36969" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="obtained new client token: AAC92slQlJVSVWYRcpoHZUE5r6ZO1+2BnZ3uT4whz/yn9Pta2wL/oXwfeive6vGHrVd+b3J2n9sg6d6miNcnMZYEr2nJNbOZF7bs/ZAd3ZgXasscNjNChQspTmrVDwcnovHwwrGpXxFEWuxaoSi9gr0LZNTE8ncuy3YZMfR+BY2aOINX5nMwX4IjNqtSXHOkz5hPBobajSUR9Cyq17cHURKUb9dNqTbhBQ7i2xhC07TI1sqTGpH12GE=" Nov 01 08:08:06 volumio go-librespot[17337]: time="2025-11-01T08:08:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:07 volumio go-librespot[17337]: time="2025-11-01T08:08:07Z" level=debug msg="completed keyexchange" Nov 01 08:08:07 volumio go-librespot[17337]: time="2025-11-01T08:08:07Z" level=debug msg="completed challenge" Nov 01 08:08:07 volumio go-librespot[17337]: time="2025-11-01T08:08: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 01 08:08:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:07 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:07 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:08 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:10 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:10 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 134. Nov 01 08:08:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:10 volumio go-librespot[17347]: go-librespot daemon starting... Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="app state loaded" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=info msg="zeroconf server listening on port 33187" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="obtained new client token: AABlOE27oyQ3r31nM0zWrjrLatT4R+SzPZQXcAQ7ufu6bXgSk7wyS5XbmPHOV402BcR1TRm1YYvAqndYJKgISJRGRzfe0T+6d1klYjgkdvo0e/uW6HLdWXRyZIT50xkIoe7nV59hDBIOK8p//5iDohGAY7WPhh7GxR6ehj24t22+P4JvvTtVueFQAsNFp9fLPcl5rkq/jtlpRk2j48WBHXotgcsssEATGUJYVrbadSlG5YgjO/9HcMg=" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="completed keyexchange" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08:10Z" level=debug msg="completed challenge" Nov 01 08:08:10 volumio go-librespot[17348]: time="2025-11-01T08:08: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 01 08:08:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:13 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:13 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:13 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 135. Nov 01 08:08:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:13 volumio go-librespot[17369]: go-librespot daemon starting... Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="app state loaded" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=info msg="zeroconf server listening on port 45399" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="obtained new client token: AAAWed8JRBg62iX1SP2al59IyNdOs6BX8XndH5DRGRW2H3d+k1Gdi7csfmyuUcvrQ0m20BW4S06hj7jVk5hSbxTzvTd0eYh/2vOgDSM3kC6R/FGGo4cBb4WocYSupW0yeegorey0Ui7pXWyuOd7kc2sb2qdjH80Mla9RZristq4NUVBZikl+0vovES35eal/N6Y7s6RvaxIm4wq8cweQL98XKbpUbD54ns27AZoB+0lfgC+7LAppVqY=" Nov 01 08:08:13 volumio go-librespot[17370]: time="2025-11-01T08:08:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:14 volumio go-librespot[17370]: time="2025-11-01T08:08:14Z" level=debug msg="completed keyexchange" Nov 01 08:08:14 volumio go-librespot[17370]: time="2025-11-01T08:08:14Z" level=debug msg="completed challenge" Nov 01 08:08:14 volumio go-librespot[17370]: time="2025-11-01T08:08: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 01 08:08:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:16 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:16 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 136. Nov 01 08:08:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:17 volumio go-librespot[17377]: go-librespot daemon starting... Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="app state loaded" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=info msg="zeroconf server listening on port 35455" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="obtained new client token: AABsbCtifPxpjFlOs8ljSql4B8IQtDRkGOJDk86f74wWGtek46+Bp7RBAhJQb+PCERF82nafhvWXl3OPY868RupxQrjyd6Do/t9KpbrtnAfaImXwbaiAfofq5llMKXzEGqJlW/QKOjqfC8b9IANiu2cSSzI2XKPGUa2GjpXysfDwuLz942PNv51kdTGFeLPEZdkgQCEGotD6NbR9lngv0OgeYfE22lOzXPFtpxt/KUF3BhoXpp+I9bQ=" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="completed keyexchange" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08:17Z" level=debug msg="completed challenge" Nov 01 08:08:17 volumio go-librespot[17378]: time="2025-11-01T08:08: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 01 08:08:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:18 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:19 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:19 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 137. Nov 01 08:08:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:20 volumio go-librespot[17385]: go-librespot daemon starting... Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="app state loaded" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=info msg="zeroconf server listening on port 35021" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="obtained new client token: AABChTBSBPEZ+bdSXkElBYJtt8VFRscpQaohuXjfwT6Xj/tnCyhqlkleUniCKHMvx4BKtsg70+QCw8Vqs+rdiRjxKpfjI/z+G3wycZrr9PUqDtgfsrH/72s7IP2+rPAECfmz9syUqusIpmoawIbSQwLbdqWOt+ou0N1jkYCaxt3CTQCwsTndwEv1TwmsYD0lgYiLhkc9H3JrNweoamiWDcrlvgV5Q4lHvAIoEdpgR0eQupisHSYy5sQ=" Nov 01 08:08:20 volumio go-librespot[17386]: time="2025-11-01T08:08:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:21 volumio go-librespot[17386]: time="2025-11-01T08:08:21Z" level=debug msg="completed keyexchange" Nov 01 08:08:21 volumio go-librespot[17386]: time="2025-11-01T08:08:21Z" level=debug msg="completed challenge" Nov 01 08:08:21 volumio go-librespot[17386]: time="2025-11-01T08:08: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 01 08:08:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:22 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:22 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 138. Nov 01 08:08:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:24 volumio go-librespot[17408]: go-librespot daemon starting... Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="app state loaded" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=info msg="zeroconf server listening on port 46233" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="obtained new client token: AACjACfH+rkeJTtyGMTMfEMKPN/iBKjH8ylABbLpZGL7LWYvxMws57N/vOVAGfS4+4MKiCxsLxBWIJ9dtJb4gGTR6K2ACCH3Ud4Bhnnn0ngn3iU60beUDOPaOpDRAogF4nWu0Jhl5roFpCj3dUKXcfuvLbbG10gN2hT+4g+C2AXsh45g30q5XuCIl6RK/BvEiVkQjMZ6KPMoLglJaeLRPqGp3BamUR5ew/eRsrah5obN4e0aGle7v40=" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="completed keyexchange" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08:24Z" level=debug msg="completed challenge" Nov 01 08:08:24 volumio go-librespot[17409]: time="2025-11-01T08:08: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 01 08:08:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:25 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:25 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 139. Nov 01 08:08:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:27 volumio go-librespot[17416]: go-librespot daemon starting... Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="app state loaded" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=info msg="zeroconf server listening on port 33433" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="obtained new client token: AACH2H8Tf8XeC+jiJYZLoSHvfZlQ5Q9hxwuIHFEaeqNmC8+G9VwGxurbLlr0T8DbN30DIEyL67HtWcDvVpjoMrk6XIBjSFw3GN34JEYJlfseXsORSXwVm2blLOPH8RllACzR0qjqqApyEF+mkNG9EdJm9647PO8E+hmus2XZzgHTCb50cldhm4yxILv7IgfNACZ2CWD/ZGKPDpQGEwbzenBp+Ej0GJpCsqRksb9lU0pui17LjSvvDGU=" Nov 01 08:08:27 volumio go-librespot[17417]: time="2025-11-01T08:08:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:28 volumio go-librespot[17417]: time="2025-11-01T08:08:28Z" level=debug msg="completed keyexchange" Nov 01 08:08:28 volumio go-librespot[17417]: time="2025-11-01T08:08:28Z" level=debug msg="completed challenge" Nov 01 08:08:28 volumio go-librespot[17417]: time="2025-11-01T08:08: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 01 08:08:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:28 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:28 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:31 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:31 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 140. Nov 01 08:08:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:31 volumio go-librespot[17427]: go-librespot daemon starting... Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="app state loaded" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=info msg="zeroconf server listening on port 46387" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="obtained new client token: AAAUtP+QVO/petpCqA/vn/+quddJjizfA7LrMP/Gf7R7kkAYliNyMFPex6cpokPhZJLnlttCHXcPebwcZSzW+04ZhBEgfI0xE4Y+0qHRuilNRjxx7LeYf+L4G487unhrCN8r3w8G+TH4gqLh/RdrQ7LWTqlPa6cgVUvDheP7PRQpjbd2QdkQ1qBfSJOTAwnmXkspiHZiqNBtS72zJJt0aerVp0VF5I7/VOIb3zxvBUMpXxGbB2a3Nc0=" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="completed keyexchange" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08:31Z" level=debug msg="completed challenge" Nov 01 08:08:31 volumio go-librespot[17428]: time="2025-11-01T08:08: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 01 08:08:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:34 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:34 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:34 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 141. Nov 01 08:08:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:34 volumio go-librespot[17450]: go-librespot daemon starting... Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="app state loaded" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=info msg="zeroconf server listening on port 46241" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="obtained new client token: AABXUxOcv2tvDkogVSDeWciSAux9VxReYHkQc+UiQDgQdE1f0qOUNm1Od4OpubNSPa9H8Z3vmDrzo2vMeNEj9uXfRnSU6unkNZL1nmJUqo2hhNyoRB+tg1kUO2UIlMmmpokbHFYK/XufQoI44CGDEsZlvSF/S/kAt+VzWFumr7h+8MqN9mmm5/VH2FthMWW1ieo0qf/DnuZzXsQcr2wbZrsibkGCmzIDJXwIGfnEjALOu83s/h9zL+0=" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="completed keyexchange" Nov 01 08:08:34 volumio go-librespot[17451]: time="2025-11-01T08:08:34Z" level=debug msg="completed challenge" Nov 01 08:08:35 volumio go-librespot[17451]: time="2025-11-01T08:08: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 01 08:08:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:37 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:37 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 142. Nov 01 08:08:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:38 volumio go-librespot[17458]: go-librespot daemon starting... Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="app state loaded" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=info msg="zeroconf server listening on port 41479" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="obtained new client token: AABS/GNCXEEAZnEOt6GbWNRO6ELB8Oh0rmtW0lDF1QhlkwIWyv8/xMZsH1FVfFGMP6LgpXQNl5TnM321pv+GEEskIAlmgHPGiAHKW9F6MV5dRDa359yBZHOE/0JQpV7xzYOQdGN8S7mEZFF9LQHAoJhjGHMxb5pckYaQH/l9zReaGi7pygtPOyT/oWd39UVNvTHb2m9erPUtpXRWXqpfNKFfUkFGTHvqds/4hzvd3Xsj53UqVVk83iU=" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="completed keyexchange" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08:38Z" level=debug msg="completed challenge" Nov 01 08:08:38 volumio go-librespot[17459]: time="2025-11-01T08:08: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 01 08:08:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:40 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:40 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 143. Nov 01 08:08:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:41 volumio go-librespot[17466]: go-librespot daemon starting... Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="app state loaded" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=info msg="zeroconf server listening on port 37029" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="obtained new client token: AAAwrkejdLr4SzAhkrkqcZdh0iQnOx8y5ye28KxTlGU95GvjGoGFZhcmgvbdyfknyEvyXoy31i6ORRhylKQ971IZ+R1DMgFAwYisfFBK/xH80C1hAo4AQHwkfsIz6uJPYy7ls8aSw8etYKzAPLgWYrf4lh/6jblHLkGLnP4ZyXwfmCxxN6ULTNkrTWqsGJSz68AftKmsQuiQ4bK5aiqWNHJY8lPm2ZADAXgFEScKXkKYDEwyGd8CSAI=" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="completed keyexchange" Nov 01 08:08:41 volumio go-librespot[17467]: time="2025-11-01T08:08:41Z" level=debug msg="completed challenge" Nov 01 08:08:42 volumio go-librespot[17467]: time="2025-11-01T08:08: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 01 08:08:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:43 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:43 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:44 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:08:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 144. Nov 01 08:08:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:45 volumio go-librespot[17489]: go-librespot daemon starting... Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="app state loaded" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=info msg="zeroconf server listening on port 35947" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="obtained new client token: AAA59yjacIQxZiQMaSM64oPtktXJFBuG0QbODH3X9yk73FVlRg2YiOSRuvYPQv29tOT+/bzhxBLZgPJpHPCfayVQr2DRbk33CzVQqGWhjH68+ePQV2O8iA2aQ83RdinDD6VQqq/ZPg0Wtrgbnr7CvrFpnsFwAIrHeaUs2iYyyJ5eWM6yIh7bVcJHj9jY+9USvBOrDbWbE/YOE5RuRmCizpNusIucbgcpb1Lw9P01NiWR68wzA6WrToY=" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="completed keyexchange" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08:45Z" level=debug msg="completed challenge" Nov 01 08:08:45 volumio go-librespot[17490]: time="2025-11-01T08:08: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 01 08:08:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:46 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:46 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 145. Nov 01 08:08:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:48 volumio go-librespot[17501]: go-librespot daemon starting... Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="app state loaded" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=info msg="zeroconf server listening on port 42591" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="obtained new client token: AABM3nHwBDP1RHapVKXdXEj/rs41FOI9TenAw/IN8Rcfhlf55snVqC2mUcr/JuDi69ZS64/ZqPxSRIqrMf0qYbLhAS/M/yMZclfDHo4ZmfyiFRKDCu7onV4+/PuPoC2Q0AUrcbpGs6ok4pRQk8XyEHNMrUgOrDARNtMPWw8DcYb9NEolXiQiCWrIBpa3Aq7eIbwKooL59EZTRheJP+oL5pQ0FhkZC/rLL1ZdU0zesdnqzM9tzXebvhU=" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="completed keyexchange" Nov 01 08:08:48 volumio go-librespot[17502]: time="2025-11-01T08:08:48Z" level=debug msg="completed challenge" Nov 01 08:08:49 volumio go-librespot[17502]: time="2025-11-01T08:08: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 01 08:08:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:49 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:49 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:52 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:52 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 146. Nov 01 08:08:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:52 volumio go-librespot[17509]: go-librespot daemon starting... Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="app state loaded" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=info msg="zeroconf server listening on port 42143" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="obtained new client token: AADtX/hb0J0f4WY1x35w93C/EjitJuBPVxY7E4KHApPPtMXyUYxPIalM6iJrRy+BNISuYBOPhIgr8z3PbAOWp/YfSbTfY9X9zQPS3IwOxvjZ4eANKkTPMf6agRkz6s3VmLXNrzIcpa+e5HYu690NRIgZbX+FeRgbuaP8G2miKjJebXFPk8OsgTbK+ERCjYV60h9kl1ldvqEqqdBNjM7fgT3QysTQye77g/XlWM0iU9UYxZ0nBdV7HGU=" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="completed keyexchange" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08:52Z" level=debug msg="completed challenge" Nov 01 08:08:52 volumio go-librespot[17510]: time="2025-11-01T08:08: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 01 08:08:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:55 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:55 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 147. Nov 01 08:08:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:55 volumio go-librespot[17531]: go-librespot daemon starting... Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="app state loaded" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=info msg="zeroconf server listening on port 39817" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="obtained new client token: AAA5K/3fM40Wqw13DaJzv3M+yUDZFSfumRcErDFVAOI7lUfQF7OgtUBcOuS1ryK74fG1CiP/mPs2Le0ZVjg9wz3b61m9A3/FqSIsDZ6qsShKe8yKjvptRVZEAzDOjGmf1x8Dbu1MwKylywFBxNaC1fXdJzNkrdZeGIaet8Ck/L7/cyHSn7/I3stbxjrKMelohWZdfFsh6dTKQHepjfzILNA5wRwtbn9y7q87MUa42iaTgzP2OvH9qqE=" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="completed keyexchange" Nov 01 08:08:55 volumio go-librespot[17532]: time="2025-11-01T08:08:55Z" level=debug msg="completed challenge" Nov 01 08:08:56 volumio go-librespot[17532]: time="2025-11-01T08:08: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 01 08:08:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:58 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:08:58 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:08:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 148. Nov 01 08:08:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:08:59 volumio go-librespot[17539]: go-librespot daemon starting... Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="app state loaded" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=info msg="zeroconf server listening on port 39571" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="obtained new client token: AABbFf3Hr/7fIxfDDKa0WHXSeWU5Fmsh0fTNgWqWrMyELmkwYvZP/nDN+Fq9iVDZjleXP8uJUgGJ6KYf7aA2iSoi2lileVKgifDeiKpmzTQdr5NMPRh/6YHqS4xNkTwXYBOc3VxnpQ2j9Bl/01hKxINOoOV3IqklDZk1A7+9tokhNEgW6r6ucqiU7+k5/tTgkrCGBjylD7ruPAwyRWtJhmuLDvjt9kuY4NhzyPcVaMBi5rG8zTVqZqM=" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="completed keyexchange" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08:59Z" level=debug msg="completed challenge" Nov 01 08:08:59 volumio go-librespot[17540]: time="2025-11-01T08:08: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 01 08:08:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:08:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:08:59 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 08:09:01 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:09:01 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:09:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 149. Nov 01 08:09:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:02 volumio go-librespot[17561]: go-librespot daemon starting... Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=debug msg="app state loaded" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09: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 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09: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 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09: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 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=info msg="zeroconf server listening on port 37161" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=debug msg="obtained new client token: AAAhPmnVMN7BS7SoT+Vpz8rFrblx3TmQJxqQQwXaaj9muTVlTlnWkTYi/PhJy78mOEOsNdGVl8FpSc68fyXTi/0ItN0siUtDLol7xy0sjRCSktuFpxvAjrY/NeXUaO4Cd89U5DgklRf9sLWOGV8FdTL5+ZVZajNzDaU62oWHNAY/fR6pfyruJHZ69D5TwPE7dW3rRkABCkpD6dyGZ9czDKeaZ8u46jcMY/U+l0RE6Sga0iViIRaWsYU=" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=debug msg="completed keyexchange" Nov 01 08:09:02 volumio go-librespot[17562]: time="2025-11-01T08:09:02Z" level=debug msg="completed challenge" Nov 01 08:09:03 volumio go-librespot[17562]: time="2025-11-01T08:09: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 01 08:09:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:09:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:09:04 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:09:04 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:09:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 150. Nov 01 08:09:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:06 volumio go-librespot[17569]: go-librespot daemon starting... Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="app state loaded" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=info msg="zeroconf server listening on port 39971" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="obtained new client token: AABcuHjd6CFmE18XdI45OhD1sCp1r/N7bJ2sjKN687NMDWSNVY39wn5JpxYCwULbEJrCsLlLfoXiBjhFsmOP1ydOs+ddhGR/KFBd6p0bbRLG5pPxFf0fXeNPtZBvjQBUfEpkhIfRHHrrAaRXqtAhZTYjKj2bciJ2JAm1BePOLhyv7lSmB/k1eyvjtMp3pM1dV60RtB4jg8UnLWLpmPw7At4Lz+NbdaGafZMMXpLcTigmVaN4270glag=" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="completed keyexchange" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=debug msg="completed challenge" Nov 01 08:09:06 volumio go-librespot[17570]: time="2025-11-01T08:09:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 08:09:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:09:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:09:07 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:09:07 volumio volumio[16875]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 08:09:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 151. Nov 01 08:09:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 08:09:09 volumio go-librespot[17581]: go-librespot daemon starting... Nov 01 08:09:09 volumio go-librespot[17582]: time="2025-11-01T08:09:09Z" level=info msg="running go-librespot 0.4.0" Nov 01 08:09:09 volumio go-librespot[17582]: time="2025-11-01T08:09:09Z" level=debug msg="app state loaded" Nov 01 08:09:09 volumio go-librespot[17582]: time="2025-11-01T08:09:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 08:09:10 volumio volumio[16875]: info: Initializing connection to go-librespot Websocket Nov 01 08:09:10 volumio go-librespot[17582]: time="2025-11-01T08:09:10Z" level=debug msg="new websocket client" Nov 01 08:09:10 volumio volumio[16875]: info: Connection to go-librespot Websocket established Nov 01 08:09:13 volumio volumio[16875]: info: Getting Spotify volume Nov 01 08:09:13 volumio volumio[16875]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=info msg="zeroconf server listening on port 36093" Nov 01 08:09:13 volumio volumio[16875]: info: CoreCommandRouter::volumioGetState Nov 01 08:09:13 volumio volumio[16875]: info: CorePlayQueue::getTrack 0 Nov 01 08:09:13 volumio volumio[16875]: SPOTIFY: RECEIVED VOLUMIO VOLUME 33 Nov 01 08:09:13 volumio volumio[16875]: SPOTIFY: SPOTIFY VOLUME undefined Nov 01 08:09:13 volumio volumio[16875]: SPOTIFY: VOLUMIO VOLUME 33 Nov 01 08:09:13 volumio volumio[16875]: info: Aligning Spotify Volume to Volumio Volume Nov 01 08:09:13 volumio volumio[16875]: info: CoreCommandRouter::volumioGetState Nov 01 08:09:13 volumio volumio[16875]: info: CorePlayQueue::getTrack 0 Nov 01 08:09:13 volumio volumio[16875]: info: Setting Spotify Volume from Volumio: 33 Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="obtained new client token: AAC+0KbmLOo2ZPmg6gbeuLaxNFEWvmMgUEhjyMyc9AykX/FEyehYawvsfLCeAq42zVeGBmGh/EYmnfqQmsCQJ1k8/l7FtF3URetqZN0viBzcmOjDLa4Ki/LNvY9HbGwndqNkaTCjfWGT1PWovBp42bp7qMAUfIZhmAa/e7SJsRic/sRc82xBqSIQRuT7faR8hhglORZmDmPUTZ3zDbIFy/cvBp63QNyqRAHjzulDvE1fCe56bgf2" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="completed keyexchange" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=debug msg="completed challenge" Nov 01 08:09:13 volumio go-librespot[17582]: time="2025-11-01T08:09:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 08:09:13 volumio volumio[16875]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 08:09:13 volumio volumio[16875]: Error: socket hang up Nov 01 08:09:13 volumio volumio[16875]: at connResetException (node:internal/errors:720:14) Nov 01 08:09:13 volumio volumio[16875]: at Socket.socketOnEnd (node:_http_client:519:23) Nov 01 08:09:13 volumio volumio[16875]: at Socket.emit (node:events:526:35) Nov 01 08:09:13 volumio volumio[16875]: at endReadableNT (node:internal/streams/readable:1376:12) Nov 01 08:09:13 volumio volumio[16875]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Nov 01 08:09:13 volumio volumio[16875]: code: 'ECONNRESET', Nov 01 08:09:13 volumio volumio[16875]: response: undefined Nov 01 08:09:13 volumio volumio[16875]: } Nov 01 08:09:13 volumio volumio[16875]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 08:09:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 08:09:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 08:09:13 volumio sudo[17617]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 08:08' Nov 01 08:09:13 volumio sudo[17617]: 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"