Oct 31 22:44:01 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:01 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Oct 31 22:44:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:02 volumio go-librespot[9982]: go-librespot daemon starting... Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=debug msg="app state loaded" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" 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]" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" 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]" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=info msg="zeroconf server listening on port 42675" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=debug msg="obtained new client token: AAAQ5CTpedIWe/mTFD6dNYgRtj6jDiw66dZHPoNlqWIUEP6JQE6hnovVt2cNp019KDtzm9cmjsnErR/CbImZiRlOu0rTh0ii37ngOh7t/aMQssu4Bu6ReQXBfUu/gjA3hwjunC9HikbpT1FZ7eiyl91uUHc1pnhjalJFCvcN8KciN6vArFMlOcXbYsDh3hIOVwtFIPGqu8670Nv618lj4CtqtGoIWva2G43joYJTSKHobEz7odAONqY=" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=debug msg="completed keyexchange" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=debug msg="completed challenge" Oct 31 22:44:02 volumio go-librespot[9983]: time="2025-10-31T22:44:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:04 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:04 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Oct 31 22:44:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:05 volumio go-librespot[9990]: go-librespot daemon starting... Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="app state loaded" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=info msg="zeroconf server listening on port 38007" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="obtained new client token: AABcjX/mLgy4zoKoL55yv4hkBvVMKufYBYbFZAIktSg9e35BS6jnozZplCAD0wwe0hlbwPcvltBECPhqmeBeKhPebkOrN8k8aEPJEAZ2CfZWBI61R076uVU0kcmPPwv9GV5QPAlduWuyrW6qF/75KDBiwubi7bVMR4Ljh59XKdegqQRRxQ4NAOCWW5i2IGYN2tcIpuEPHdORpYQ1Xek5JysXbpuGQlGofRYEsWVR53RyMRrOUq+9X6s=" Oct 31 22:44:05 volumio go-librespot[9991]: time="2025-10-31T22:44:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:06 volumio go-librespot[9991]: time="2025-10-31T22:44:06Z" level=debug msg="completed keyexchange" Oct 31 22:44:06 volumio go-librespot[9991]: time="2025-10-31T22:44:06Z" level=debug msg="completed challenge" Oct 31 22:44:06 volumio go-librespot[9991]: time="2025-10-31T22:44:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:07 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:07 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Oct 31 22:44:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:09 volumio go-librespot[9998]: go-librespot daemon starting... Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=debug msg="app state loaded" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" 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]" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" 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]" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" 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]" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=info msg="zeroconf server listening on port 38533" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=debug msg="obtained new client token: AAAZd6ZzaRpKvkpP2RqOoQLE+I3UWbfSWr5RJDiiz7NdLKZMatj1ACrVI+Lz0YmfYRH3CQT5RhR+IswhReq8qCOQXxcipKrirSkRmJrA3cGUw0Yg3Oo4EXE5irj3kwZTu7KHZ3jhvSDNsCTxsYb58OepTYdz6Z2ihd5yoW/WbPmpgI+sTXqDesII+fzCGKju8TptI4N9nYaD/i45lwNV6E7Tx7YJqewQg9sHxlTziVYqcN2lXcc+Nu8=" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=debug msg="completed keyexchange" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=debug msg="completed challenge" Oct 31 22:44:09 volumio go-librespot[9999]: time="2025-10-31T22:44:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:10 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:10 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Oct 31 22:44:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:12 volumio go-librespot[10020]: go-librespot daemon starting... Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=debug msg="app state loaded" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" 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]" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" 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]" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" 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]" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=info msg="zeroconf server listening on port 38827" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=debug msg="obtained new client token: AABbghAg9g76I8fxDEacM2SdA+pQ/KS12ok+WRiYz1efr7O92Hpv5hoOsovuLm35l8ykRohY4OvB4nqqUltN8F1WaIe9suWVuxo22banS/EP763fjL9QcOfV53hiV6PiXeSGCxswv/qwI+lhR6SB7imzMhGGoZeNCw8AZKws4UoCvCvSJW7kN1DAywVw3Sbestya93xM0lpRsZ+lA86hs4w9H1GH5SgI235J+ZdDpbQNNbYAwdo+d5w=" Oct 31 22:44:12 volumio go-librespot[10021]: time="2025-10-31T22:44:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:13 volumio go-librespot[10021]: time="2025-10-31T22:44:13Z" level=debug msg="completed keyexchange" Oct 31 22:44:13 volumio go-librespot[10021]: time="2025-10-31T22:44:13Z" level=debug msg="completed challenge" Oct 31 22:44:13 volumio go-librespot[10021]: time="2025-10-31T22:44:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:13 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:13 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Oct 31 22:44:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:16 volumio go-librespot[10031]: go-librespot daemon starting... Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=debug msg="app state loaded" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" 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]" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" 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]" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" 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]" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=info msg="zeroconf server listening on port 38709" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=debug msg="obtained new client token: AACHyuJ7MeXty7TL14tgP3HOTXM9yb55hT7FA+fUtuiMS8c6qceM79wkzDUt0I38f39secXFyqaFEsZ53zeEYfr0/8SjSJ+B6+YfRDXf4KUTZc0kUIBw6e9nUj9kaogXXKjaJKf5oLCE2D66czowZQAUMBnziwwuh9BwOdb3mjMIE2HyUfG9wfy3CsISF5bq2u7mWy/+C7FDmq2R0IIlVLXuC84TH73haMWbUYDz4T8ouw2MSBLTmiM=" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=debug msg="completed keyexchange" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=debug msg="completed challenge" Oct 31 22:44:16 volumio go-librespot[10032]: time="2025-10-31T22:44:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:16 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:16 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Oct 31 22:44:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:19 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:19 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:19 volumio go-librespot[10039]: go-librespot daemon starting... Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="app state loaded" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" 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]" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" 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]" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=info msg="zeroconf server listening on port 35741" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="obtained new client token: AABBU3epLE4GCvia3fDVjOuTJGDVAoz1Gq7ynHuXbEmSFzeQbbcDTOaMSB9P1vx5ifNpYjyd3j1qPc/jHeZE3i7AwtjrKE2I5Rahn/kFQKY6fHyiWBMNUAfX9dZXn7qsDPEnezJsQEw+PzlL4m9vPR664g1f/90ietqSw3F2Ny7m38ffP2TUL7YS23qyJAT0PF0F3P8LDVNGmyzYX/qF4cP88dlhxGe9aWVhAluF6sX0DzvT7CDjNRM=" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="completed keyexchange" Oct 31 22:44:19 volumio go-librespot[10040]: time="2025-10-31T22:44:19Z" level=debug msg="completed challenge" Oct 31 22:44:20 volumio go-librespot[10040]: time="2025-10-31T22:44:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:22 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:22 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Oct 31 22:44:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:23 volumio go-librespot[10062]: go-librespot daemon starting... Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=debug msg="app state loaded" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" 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]" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" 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]" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" 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]" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=info msg="zeroconf server listening on port 39493" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=debug msg="obtained new client token: AABxFfJ5gsqeD0TrqJkA9vz4by5TDni4Q+Pjv/w2ULvds8AhdJcd9AlWrFtsOJ1p4EB35Fa/PU0UMCXHFXRShyGFCNWHMwtBWB7Rnx7ZLc1vZYGnlbSG0yn55c96Bdl7wTTb9H0HECF4vIZh/aPT1+QAe8IKXyOBC+1owPKhMzQxSXbB4aRCzjdKJ4zW6CzXtbmaL9bnp3npPD3MKhhUIbUsu21vNtAmR1RWsSvaB5HRACjpqUljoCc=" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=debug msg="completed keyexchange" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=debug msg="completed challenge" Oct 31 22:44:23 volumio go-librespot[10063]: time="2025-10-31T22:44:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:25 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:25 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Oct 31 22:44:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:26 volumio go-librespot[10070]: go-librespot daemon starting... Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="app state loaded" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=info msg="zeroconf server listening on port 34013" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="obtained new client token: AACdunaVQnopN4F3AWTShsJ/SZQsL/Q6ir+JyYDJUEn7h6ffWvtb+XcOuwP+6z7oLAuuW6EeAVoMcNoKSY4WUmXYDJ9swgfLKc5MrWCi2b0aTMqWi65kUKIVumPWwA2BnsEMNF+tElaZhgrB5A//1B5WeP1tw1TgUQ+44L/x9/v5BwW2QVBzD7WqIH41VpsPOAf6Vfq9cyjMpB0oHUtvB5MQFVB1uy4Nfbsfauzh43xz23l8MaBfJ+k=" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="completed keyexchange" Oct 31 22:44:26 volumio go-librespot[10071]: time="2025-10-31T22:44:26Z" level=debug msg="completed challenge" Oct 31 22:44:27 volumio go-librespot[10071]: time="2025-10-31T22:44:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:28 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:28 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Oct 31 22:44:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:30 volumio go-librespot[10092]: go-librespot daemon starting... Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=debug msg="app state loaded" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" 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]" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" 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]" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" 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]" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=info msg="zeroconf server listening on port 40143" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=debug msg="obtained new client token: AACcd//qVxuDX6PjJ2Yd9ZsZSmRJjUs9m/N7d9oJMCbCYqNOxA8Ja2bnLVzuHRzHwCPqrLvKStDnlM7YR9Nf9feiwK83auu/DhkIKjUU3nIkZXr1ggr/2+4m1qFBx3oYvxKqF4S/YZViptdYRQDleMi5hTpgsVAkKfinc/WnMypylropnTIaHFExzpk1l3T3kTluEjR3ylVFgxwPxFSQoVXG/f5aEvc26xWQBBw8nN0SdrSC8DJJ3xs=" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=debug msg="completed keyexchange" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=debug msg="completed challenge" Oct 31 22:44:30 volumio go-librespot[10093]: time="2025-10-31T22:44:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:31 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:31 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Oct 31 22:44:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:33 volumio go-librespot[10100]: go-librespot daemon starting... Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=debug msg="app state loaded" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" 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]" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" 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]" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" 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]" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=info msg="zeroconf server listening on port 42691" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=debug msg="obtained new client token: AACPjHy/bovLgBQTwOvYABhs0Sfh67mJycbhbOOjXTiFrUD4faPmG0BPmRQsPcB7LLFokb3clzEXOGBcshXLxxo4dZm3B3IMAJyFeCqYMstlKvxV+Y0VvwCI8dq3urCjqSWHdY9HX0VkTgYQo2YEr51NtkNqY+5QKSXe66kXOO42EPB0pSuoODaz26+ijtwCjV20XhAp370DbmRTUEHTOHvige1WBCjsGJmpaifuoRa2rdb67y9KTPM=" Oct 31 22:44:33 volumio go-librespot[10101]: time="2025-10-31T22:44:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:34 volumio go-librespot[10101]: time="2025-10-31T22:44:34Z" level=debug msg="completed keyexchange" Oct 31 22:44:34 volumio go-librespot[10101]: time="2025-10-31T22:44:34Z" level=debug msg="completed challenge" Oct 31 22:44:34 volumio go-librespot[10101]: time="2025-10-31T22:44:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:34 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:34 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Oct 31 22:44:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:37 volumio go-librespot[10111]: go-librespot daemon starting... Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=debug msg="app state loaded" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" 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]" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" 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]" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" 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]" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=info msg="zeroconf server listening on port 39781" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=debug msg="obtained new client token: AABLuu38LTsO3T5OtSZNcIOxE7daCnTOSelVyzm3qSDsQDg7C2/A3CCuezK4zN8oEUgzsX6mc9m47MslF2CHdgpyO8RIE8+kKrSScbIeM+hCjThOJkcPDfSjddibHq/IjT8czGX9KdOud2AwKIyd8IT7LKnXqnrrtwBOpDmxqjBk2aQ8pFStdIrEn6EVmsCbUsL9TnVl3ZUZD18DYbBtjgkGmzK5CMpifvvmhn7AzqLXvUGP+ziVE6s=" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=debug msg="completed keyexchange" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=debug msg="completed challenge" Oct 31 22:44:37 volumio go-librespot[10112]: time="2025-10-31T22:44:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:37 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:37 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Oct 31 22:44:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:40 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:40 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:40 volumio go-librespot[10134]: go-librespot daemon starting... Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="app state loaded" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=info msg="zeroconf server listening on port 44661" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="obtained new client token: AADy01dNnFsOuqsLe/GtLfXJo7O/kCLJm8gP1Q+VJ0IshyQGDPGIzY3r9geh+kqiHl3C3juibsD+j6QVKD6bL20l5Mb81esHIbbYCvVeMrXXJ3EJ+/5uQZGGBxNnOrKh5GYFVRsHJ8cbxJ2vMoK09li9DBSeuvJQAVtHFab4bYyV59umn4QkXTNhke9vTc9AWEuy42kDxJSLZ/O5ag1YqClJDoOT3KkivPotM79m96tQyRWATsohlqM=" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="completed keyexchange" Oct 31 22:44:40 volumio go-librespot[10135]: time="2025-10-31T22:44:40Z" level=debug msg="completed challenge" Oct 31 22:44:41 volumio go-librespot[10135]: time="2025-10-31T22:44:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:43 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:43 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Oct 31 22:44:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:44 volumio go-librespot[10142]: go-librespot daemon starting... Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=debug msg="app state loaded" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" 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]" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" 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]" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" 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]" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=info msg="zeroconf server listening on port 32897" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=debug msg="obtained new client token: AADquFC60uQR3b1kpCf7Q5xbMvYQjsoijEJSLuOS/CSVDVQDUEMgWv9lHOn+/jJH2zYmUHsV2+o9rZcK3asz0Al9eLsds2zpha7NPb2nAK2K55/wptDPGjsCvOChTaalWpj3RKx5Jonq5yBKmLhZ1o9EyC3yDoKFdn5VfHvkNUtOXnc3TilOPl3alZrCTXhu2E6cHbR5/VmwjMfZZrt3VDBJl/A2j7KuwNzypktTfkYBV3LRGjqROq4=" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=debug msg="completed keyexchange" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=debug msg="completed challenge" Oct 31 22:44:44 volumio go-librespot[10143]: time="2025-10-31T22:44:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:46 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:46 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Oct 31 22:44:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:47 volumio go-librespot[10151]: go-librespot daemon starting... Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="app state loaded" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=info msg="zeroconf server listening on port 33409" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="obtained new client token: AAChyDHCor1WeRuRwk6HMVMCL1dfe1O00lNI/Rv75VrGzJM65l+TV4xwLXSEKg9+GKwQ3oIu122Ecm/1HRtSCQazQ2Si/2qdMtAryXiMNXCBYhL+A9oUjwUdCTBS9W9oqB/B6eMeOIDUWMPYZc4PgBJOrLpJFYq+ouPddKJVLG5+cYN8TMsMoi58irNBe/ABrwJnOqDvHHLFXuBb6OLVOej/8tWjOYtaDuN+vlPueVYwiVE5dHdkDIc=" Oct 31 22:44:47 volumio go-librespot[10152]: time="2025-10-31T22:44:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:48 volumio go-librespot[10152]: time="2025-10-31T22:44:48Z" level=debug msg="completed keyexchange" Oct 31 22:44:48 volumio go-librespot[10152]: time="2025-10-31T22:44:48Z" level=debug msg="completed challenge" Oct 31 22:44:48 volumio go-librespot[10152]: time="2025-10-31T22:44:48Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:49 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:49 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Oct 31 22:44:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:51 volumio go-librespot[10173]: go-librespot daemon starting... Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=debug msg="app state loaded" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" 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]" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" 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]" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" 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]" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=info msg="zeroconf server listening on port 34387" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=debug msg="obtained new client token: AADgxG0kG5PPkaAtK2WNYZlW7N+PWuslV41KEtGjpfhIPHXbAwclBCka1p78LHOkEenidCihUwqkkGvQyztscPdxdhDm5H/+eZtqEq9D5uw+LZKBhiq6TThyEx9mbrOVCh+m91am1hSxkKqe8G60T0g1tRYXprQ/XLDwFWMGD7I0RphzjZ/SaJrMsiSoEEubkEpFryClyVIDg3C6lHebX28ZCqZhI2mkmbEf4krIYGnL6qqog82OwOE=" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=debug msg="completed keyexchange" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=debug msg="completed challenge" Oct 31 22:44:51 volumio go-librespot[10174]: time="2025-10-31T22:44:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:52 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:52 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Oct 31 22:44:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:54 volumio go-librespot[10182]: go-librespot daemon starting... Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="app state loaded" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=info msg="zeroconf server listening on port 38141" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="obtained new client token: AAA4wtiGnC9uLnsx45aKIv7U8znsxOiqgTGkOdksR3mY44iy+nGuvI5Ara1XrDlp20fQWScszpFmCceAzy8XVpYgELwm+wmUqOoQqc5+RdL0XUVwsrwc4QCwUkh/aI7p8q+wWmjQd4m5dtUQBA9TCWRKDRgl7TzAEfvhgLPKcXRIrKCrNMBL1hDNl6WoMW1II3hBnTzDQOPBcwzxiuWTrk29rSu2mEur0qmohSufAIYZpahim04DGSU=" Oct 31 22:44:54 volumio go-librespot[10183]: time="2025-10-31T22:44:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:55 volumio go-librespot[10183]: time="2025-10-31T22:44:55Z" level=debug msg="completed keyexchange" Oct 31 22:44:55 volumio go-librespot[10183]: time="2025-10-31T22:44:55Z" level=debug msg="completed challenge" Oct 31 22:44:55 volumio go-librespot[10183]: time="2025-10-31T22:44:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:55 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:55 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:44:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Oct 31 22:44:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:44:58 volumio go-librespot[10193]: go-librespot daemon starting... Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="app state loaded" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" 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]" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" 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]" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=info msg="zeroconf server listening on port 45577" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="obtained new client token: AAB3BcU1/5uDM+c0flj+qIW4dIjrrEp8uYpr4yftAlQTtCW4VOrOcPjwDIItGIImY3DQ3wGUWpwD5TIbHYtWUrbhawN1tqCVFOE+jB6mEAUd42VDVStrwBHXe5Cfid6Ood6gD1zLjjw5XTWWj9PY5jeNUCwPuKFPRKH69haBb9lULsca6ZWLNEXjXkklvNLt3PRf5c8fJG7lNEj0ECRysAXyamiQLorOMz90xHlQJVICzLwpTvIVBtY=" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="completed keyexchange" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=debug msg="completed challenge" Oct 31 22:44:58 volumio go-librespot[10194]: time="2025-10-31T22:44:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:44:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:44:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:44:58 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:44:58 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Oct 31 22:45:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:01 volumio go-librespot[10215]: go-librespot daemon starting... Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="app state loaded" Oct 31 22:45:01 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:01 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=info msg="zeroconf server listening on port 40585" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="obtained new client token: AABeahSF5E7OJL3Y+ajWuMxuwwQgt4wes/KTEPsFIR2rCl1T22PFAJ67LvfsXxfFZXhFx6U07S9s3tlT7CrG7DjXe3VQ4PX0kvOMGZhdOhUcBpygpatyp8rHBdLtYwXPe5djEkizTXbnlyQk66Z47hkguBod2pp0A3PxmJDYhSVVAce35kWcDmm7MMnPWa7LX4Wl8UGjtuPvNMI/g/19D7+4Q58ofUhxeqvFngDHMnLALafKOwOajw8=" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="completed keyexchange" Oct 31 22:45:01 volumio go-librespot[10216]: time="2025-10-31T22:45:01Z" level=debug msg="completed challenge" Oct 31 22:45:02 volumio go-librespot[10216]: time="2025-10-31T22:45:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:04 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:04 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Oct 31 22:45:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:05 volumio go-librespot[10224]: go-librespot daemon starting... Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="app state loaded" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=info msg="zeroconf server listening on port 37217" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="obtained new client token: AABP9iZ8NYD5BXRsuqki5Py3/YvaXT88nLnm4PfynIgW8ldfFaYWC+ZRP75MJobteu1AQ5ucW4Cwcwx62q1jo1uNf+CHMEtxn/ushjI5IruSA8CEeuvn58/LUrxLcxb9rMbJBF5UbpmN/JD6D0xG8SnrXoCnybEQyf7+Lt5vKv0mYyEhPq7+cT64hP3VsnoUNakOdynAGPADsCJylV+4Dyr53zQjWYwWc7HvpIs5/Lp4AIJBG6QdLhU=" Oct 31 22:45:05 volumio go-librespot[10225]: time="2025-10-31T22:45:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:45:06 volumio go-librespot[10225]: time="2025-10-31T22:45:06Z" level=debug msg="completed keyexchange" Oct 31 22:45:06 volumio go-librespot[10225]: time="2025-10-31T22:45:06Z" level=debug msg="completed challenge" Oct 31 22:45:06 volumio go-librespot[10225]: time="2025-10-31T22:45:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:07 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:07 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Oct 31 22:45:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:09 volumio go-librespot[10233]: go-librespot daemon starting... Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=debug msg="app state loaded" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" 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]" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" 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]" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" 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]" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=info msg="zeroconf server listening on port 46035" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=debug msg="obtained new client token: AAC8EJB4RtKYNSGJImbnhQ0A5l7iP4vPTAjKKnibNJcKVuidkmEbPsOCSCi/PSVhm/VpktTORevXNm2qiBBtWVUNDOpqKGClwemGXu1m9q3eQa/bC0dfKBI2ac/dXaFgDX83ixH4t8nuF09y3ejkrgInbNiFD84eFt2PRwpOOUBmm6NZOEPLCJu/rXSKCuemvYxht1ypTmVISxIcATSOGO1c5iAFqF5cPLILbEehcAhDXPZbfNPZpxs=" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=debug msg="completed keyexchange" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=debug msg="completed challenge" Oct 31 22:45:09 volumio go-librespot[10234]: time="2025-10-31T22:45:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:10 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:10 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Oct 31 22:45:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:12 volumio go-librespot[10255]: go-librespot daemon starting... Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="app state loaded" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=info msg="zeroconf server listening on port 44519" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="obtained new client token: AAAhcrKXmk2ElIbj1EgaavqxDwc3GqLUsK1E37d+DIKQFkZxPN6bqh75NcYDV0u/I6AqqwuLyWB2TzjLm6FelxoqxYewHMw1K3jHGEmnbwn9tqoI3WPWiXoUpRC/Uw4fbTcVESsZgWMIho0dcFKUppxQ2MHe/AXIbWiCZQo5WV5uPa5G3sQpzV4mbWQreP1PxAxACpkFRmJWEuYpPJD2nxUw3m3Z4et2TdMRo3nPouhpLT8vGtuViaM=" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="completed keyexchange" Oct 31 22:45:12 volumio go-librespot[10256]: time="2025-10-31T22:45:12Z" level=debug msg="completed challenge" Oct 31 22:45:13 volumio go-librespot[10256]: time="2025-10-31T22:45:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:13 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:13 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Oct 31 22:45:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:16 volumio go-librespot[10266]: go-librespot daemon starting... Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=debug msg="app state loaded" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" 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]" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" 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]" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" 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]" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=info msg="zeroconf server listening on port 34673" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=debug msg="obtained new client token: AACFtpnpf8LZgkbsKB5AfjFIRIJU5Ab3e1KjTXs21T+6DPpPpLH8bLo+0Ba81x9QooLWsFNJ5MsvWY5wEUJiuDLQ8OHoxD4msHouHhFeAseDcC5itFFxS6klcSQLO25//nVurpdd/UdmvwZQ/Ti2mvQhQhKWt72MF8k4ivQKzl6ujln7c5n2bthfX5lJzC97I+FnLHJ8IrobldCkFdF4oslRzZkCXnTl/5x7UD/7uumgnrmaPP7N8Bs=" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=debug msg="completed keyexchange" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=debug msg="completed challenge" Oct 31 22:45:16 volumio go-librespot[10267]: time="2025-10-31T22:45:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:16 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:16 volumio volumio[9397]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Oct 31 22:45:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 22:45:19 volumio go-librespot[10275]: go-librespot daemon starting... Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=info msg="running go-librespot 0.4.0" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=debug msg="app state loaded" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 22:45:19 volumio volumio[9397]: info: Initializing connection to go-librespot Websocket Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=debug msg="new websocket client" Oct 31 22:45:19 volumio volumio[9397]: info: Connection to go-librespot Websocket established Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" 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]" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" 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]" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=info msg="zeroconf server listening on port 38645" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=debug msg="obtained new client token: AAALOswU+qhmXj0TLnR/8GqnxtK/KukTPes6i+duS3acnTsNbMIU/Axo2OWuqGgc/UCdB0doFVnw80jJdSpd53I0nLI1l5nePU1GnGMx/OwYJ+1qDSfYbiqZs89bMTUKGf17OjCmeAAjurUUlOb8OURPwmha+7efqEJwtW+4Rm08q8KBQkAUSFUtFRFlWIxDBnvUFsWrxqumlh7juF33UTIRB1jkBsu8b+K0yrV2hOOZryBLrD5jnls=" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" 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" Oct 31 22:45:19 volumio go-librespot[10276]: time="2025-10-31T22:45:19Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.65.9:443: connect: connection refused" Oct 31 22:45:20 volumio go-librespot[10276]: time="2025-10-31T22:45:20Z" level=debug msg="connected to ap-gew1.spotify.com:80" Oct 31 22:45:20 volumio go-librespot[10276]: time="2025-10-31T22:45:20Z" level=debug msg="completed keyexchange" Oct 31 22:45:20 volumio go-librespot[10276]: time="2025-10-31T22:45:20Z" level=debug msg="completed challenge" Oct 31 22:45:20 volumio go-librespot[10276]: time="2025-10-31T22:45:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 31 22:45:20 volumio volumio[9397]: info: Connection to go-librespot Websocket closed Oct 31 22:45:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 22:45:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 22:45:22 volumio volumio[9397]: info: Getting Spotify volume Oct 31 22:45:22 volumio volumio[9397]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 22:45:22 volumio volumio[9397]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 22:45:22 volumio volumio[9397]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 31 22:45:22 volumio volumio[9397]: errno: -111, Oct 31 22:45:22 volumio volumio[9397]: code: 'ECONNREFUSED', Oct 31 22:45:22 volumio volumio[9397]: syscall: 'connect', Oct 31 22:45:22 volumio volumio[9397]: address: '127.0.0.1', Oct 31 22:45:22 volumio volumio[9397]: port: 9879, Oct 31 22:45:22 volumio volumio[9397]: response: undefined Oct 31 22:45:22 volumio volumio[9397]: } Oct 31 22:45:22 volumio volumio[9397]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 22:45:22 volumio sudo[10311]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-31 22:44' Oct 31 22:45:22 volumio sudo[10311]: 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"