Nov 03 20:54:00 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:00 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Nov 03 20:54:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:02 volumio go-librespot[1853]: go-librespot daemon starting... Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=debug msg="app state loaded" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54: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]" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54: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]" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54: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]" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=info msg="zeroconf server listening on port 40145" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=debug msg="obtained new client token: AAB8o9Zyt8QjkRnD6Med9caN87wMgk2D+5SSf/dh984Yklj9Zxu+tMECsnI1JJs5lCh3zdtftJVzY1/pXXZyrBwsYXHcQ+ju4QKUql0rwCjsdTUa9CVPptz4syZ3khRQd4hEHwr9Eh15hhzqP/EKE/JXTWPL0muUN5aayxxC0Zf2Paxg4IfIHTlaOjwQOjVqYtUp7k4RVol+tlxq3zWX67Lm309B8ihOViF/lnPzqKl21zYp17WA" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=debug msg="completed keyexchange" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=debug msg="completed challenge" Nov 03 20:54:02 volumio go-librespot[1854]: time="2025-11-03T20:54:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:03 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:03 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Nov 03 20:54:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:05 volumio go-librespot[1865]: go-librespot daemon starting... Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="app state loaded" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" 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 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" 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 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=info msg="zeroconf server listening on port 43015" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="obtained new client token: AADLhb/EO3ciQthW8mIQRclMofN3QQAyDnhKKbal4nrG9qkToepW3/0gCH7ANHwV3IjMLXWaGxNCCJDaBFpeEq5BjIyACeajgk1PxTsbKqxQjhDEJAO43gCYtvTkiEZuSboWmCfzl3mbsUltFvSmAiJnEviibWLcy6xd91UAP8zBXi+vRAh0bpP8j2f3dFWjd1Plf9wL4P+o5zy2ICWopbaohR6skzVMckmY2zYK2YzBAWmpnCznOpk=" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="completed keyexchange" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=debug msg="completed challenge" Nov 03 20:54:05 volumio go-librespot[1866]: time="2025-11-03T20:54:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:06 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:06 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Nov 03 20:54:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:09 volumio go-librespot[1887]: go-librespot daemon starting... Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="app state loaded" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" 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 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" 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 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=info msg="zeroconf server listening on port 35135" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="obtained new client token: AAAeHv5PsnB7vrRFUzvBLg7PIy0PfyJpwT2kyf51bduBYjbfiHiwgMP3Ilz/bFngHGGMt5QTex58hlyXxJKr6H3K6S6U87feBlO7+/fEtBT30ZJpgPzLgsgQfiILHLOxMXDm3r3CjYr7VVnG2FjOu5pvK9fEQB1vOvMM7qv8/fLDPcUO4KQPVW9zEczUYUthy8Ukg/jXCowfBrgh3o+1LJY1gYLPoWs4Byzzon33WMhzwnqIJBBb" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="completed keyexchange" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=debug msg="completed challenge" Nov 03 20:54:09 volumio go-librespot[1888]: time="2025-11-03T20:54:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:09 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:09 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Nov 03 20:54:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:12 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:12 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:12 volumio go-librespot[1899]: go-librespot daemon starting... Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=debug msg="app state loaded" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54: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-gew4.spotify.com:80]" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" 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 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" 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 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=info msg="zeroconf server listening on port 37661" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=debug msg="obtained new client token: AADDJwZLyJzcj4RRjCUULMmOt3BkmB56sHnRde4QOF0d3SGdu2mTJb0re8CXrrhd94Kv809X4JGG0vawfc+bkh2UJ/4DuylWDTnTXYzPkX75IqB02k5Nm8LtNnspRy9UjURBqg3MroveZ4cEhD7RkCM/F7H7A+sX5jIgx6+hQUuTgk+paFDqFu26G3cgZrPOVdFgXoSghIR9HcVK7+W09/TJLLrDgNjOVqBTBH++pryF+mJBGMfZz2I=" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=debug msg="completed keyexchange" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=debug msg="completed challenge" Nov 03 20:54:12 volumio go-librespot[1900]: time="2025-11-03T20:54:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:15 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:15 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Nov 03 20:54:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:16 volumio go-librespot[1908]: go-librespot daemon starting... Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=debug msg="app state loaded" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54: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-gew4.spotify.com:80]" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" 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 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" 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 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=info msg="zeroconf server listening on port 42839" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=debug msg="obtained new client token: AABpeYPSKybGbRDZiURGhD+W371asFDhT0UkjIe0qoXDTu4cTuuLfyyN5HJ4AOuFfIXoDHfr99wxy2K5hXUz8uEDOObNVuqmosuwDQMPQ9VID3djIsD6Va6RA3z2kMsYq3M0JkMPMZ+7cr6759OuKerInMfetuIfoXunO3rhoNYyTrsfK0QnqmTXwcqiFw5IQQGedTG/ZHAS2piB3htbRAyhN1MGe66wvKaNFnPdmmGK4lcy07Zo" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=debug msg="completed keyexchange" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=debug msg="completed challenge" Nov 03 20:54:16 volumio go-librespot[1909]: time="2025-11-03T20:54:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:18 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:18 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Nov 03 20:54:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:19 volumio go-librespot[1930]: go-librespot daemon starting... Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=debug msg="app state loaded" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54: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]" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54: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]" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54: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]" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=info msg="zeroconf server listening on port 37037" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=debug msg="obtained new client token: AAA5nxVwAX36nNA/KqNWnr8KURxQkJLpxPeWHhFTqHdcezqAIThHYUXYHtdIH7qBz2RRUaR+qEWVl0FM0GorSZUwRztQSx2PH9+xUY4fAJ7i9SXasZGTedynO5+nkZ0qi0qQ/jNhhbvTctLXNZ+6FNKFjTp5k4hWvZm0Jhxp5bzgPnR+v5/h1e7cIZ5sfs7AxAH705/Fhoy+rJcCaGwKY+bbbOqo7R8r9lfGBLDtndDUZzHADK2DBZM=" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=debug msg="completed keyexchange" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=debug msg="completed challenge" Nov 03 20:54:19 volumio go-librespot[1931]: time="2025-11-03T20:54:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:21 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:21 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Nov 03 20:54:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:23 volumio go-librespot[1939]: go-librespot daemon starting... Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=debug msg="app state loaded" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54: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-gew4.spotify.com:80]" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" 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 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" 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 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=info msg="zeroconf server listening on port 32837" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=debug msg="obtained new client token: AABnfIssuONfTPanzMseyq3Anw7L6Ko5GzfSFd/upsBGR9M2oXMc6inNbvGinQNn0bsj46Y4NWVj0BztRWpFN8HtGjZiZnGlxKT62BdP/rj9IadVyT8Qmf0g/d69gIeBpsQgeVSwThSMMewy4VtboSer3MBjWbaMqCwJio+Y1yUotC1L9pDcD1rlA0ADt9P0VzIhlwyvYDIzmXXlqrge3/6FpxMPP+VI/NWKOE4TknoMhPT7evUO" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=debug msg="completed keyexchange" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=debug msg="completed challenge" Nov 03 20:54:23 volumio go-librespot[1940]: time="2025-11-03T20:54:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:24 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:24 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Nov 03 20:54:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:26 volumio go-librespot[1962]: go-librespot daemon starting... Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="app state loaded" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=info msg="zeroconf server listening on port 45835" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="obtained new client token: AAA43tAb7NAAa2ZHwAtxOjIVKxxZHdXYGgPuyQsmvgnTCMMkm0BKveE47yLLF7R25/O8LE/30T66V3j+vm7TYgNTLV1Uum433UeszIlg3Zy2OkTir+T1k7HyS3EfunlBtsa0NnWVQiHnbbuatWl4wC2r/dBy24nFWizQDR1HLYvgkUIFXslFPxVw/3jYwElnhzng2RhDrRtxMz8DzGSTLpdmS/ZjvvqLKVRbG/hrXgqyQo8Sn840EvU=" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="completed keyexchange" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=debug msg="completed challenge" Nov 03 20:54:26 volumio go-librespot[1963]: time="2025-11-03T20:54:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:27 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:27 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Nov 03 20:54:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:30 volumio go-librespot[1970]: go-librespot daemon starting... Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=debug msg="app state loaded" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54: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]" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54: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]" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54: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]" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=info msg="zeroconf server listening on port 42307" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=debug msg="obtained new client token: AAC5R7LGmTgfHc4BJrsTpTxIuxeE5ympCPN007CBcLL69E46d9HxmvrIk1YAjXU9oDMkDKA0S37jC3qvR3gXIz2TbksnE3RbTBaS67OQgBjY9FMsH2+hovVB//AaF3k0kX+wihBq0RLl8tAadmgHLIWMstgeQM5nJy3yduGQr7k5BVtEaCLNEptIVk+Ei9PuKWl9YtqhzA6rp9tLb73LlGXUgXllua7HUQWAgRetSm7qTzgpfNDm" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=debug msg="completed keyexchange" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=debug msg="completed challenge" Nov 03 20:54:30 volumio go-librespot[1971]: time="2025-11-03T20:54:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:30 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:30 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Nov 03 20:54:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:33 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:33 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:33 volumio go-librespot[1981]: go-librespot daemon starting... Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="app state loaded" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=info msg="zeroconf server listening on port 46239" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="obtained new client token: AABwZk4AawOUIZlU8rMpX9/MeAgw0qE838GW1uHPAmc7HtLjG8MneA+JxqwcB/0kvomStymMQ7Ghd5DlbYPl8b5uyvLCeBqLC4w+N17ZtEZpPye5jkEgaS4Yw9WxhHSv2/c498V49LYHWz3j+cXdBxArPAHKOoJVs9vfQbCRtjs48/Qlpb3Hgg42AQZcb9GwjphdtzSntXq169x4lFh1MqF6h1IPzLcHeZmfdZU4WYVnwpy4stBDAy0=" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="completed keyexchange" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=debug msg="completed challenge" Nov 03 20:54:33 volumio go-librespot[1982]: time="2025-11-03T20:54:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:36 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:36 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Nov 03 20:54:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:37 volumio go-librespot[2003]: go-librespot daemon starting... Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=debug msg="app state loaded" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" 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 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" 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 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" 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 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=info msg="zeroconf server listening on port 37707" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=debug msg="obtained new client token: AAAiFjht8IXWxmhQ3KrmXu4fbO15kdFg4MOA5SwRKUN+tfHB0x9utB8rZGP4so/+30I1/iDed89BPB3U6F2CEbsMWXPONS2wneC5/MgvEyaYMYLxMjmEVY3bAr50C1O6yDvcqszVIV2jL5UwVRYkTTX24KNU9KuKFgfkfrcyhrS5fNo8X5dwo6GMzXEcZhlSMh3ECdJ1WSAE3Ez39c+XSvWI1XwSUegfhn3NeZqR3+YqpO2l853i" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=debug msg="completed keyexchange" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=debug msg="completed challenge" Nov 03 20:54:37 volumio go-librespot[2004]: time="2025-11-03T20:54:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:39 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:39 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Nov 03 20:54:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:40 volumio go-librespot[2011]: go-librespot daemon starting... Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=debug msg="app state loaded" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54: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-gae2.spotify.com:80]" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" 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 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" 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 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=info msg="zeroconf server listening on port 46403" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=debug msg="obtained new client token: AACV8MFaTiLRD5zpygepbd3+zbvwz0LMzR3zWlNLiEw/HqNNTgjOyJoc/n7TErgxBeBicAY3qfatdZkdcJvNsKMNr7ciAeDkexebBJ21qDl82thzrdQtQbgqQGXjd47BZQmZWSNvCs/DiWl2am1cdrlRv0aZBIoH0Y2bchwXubo9S8yx3y3n8hAkgh3/pQppr7fryaOr/vgZjUx8x48lcobZSjrnHHsD0SzekdWa3h89JoKW2TT4T1g=" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=debug msg="completed keyexchange" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=debug msg="completed challenge" Nov 03 20:54:40 volumio go-librespot[2012]: time="2025-11-03T20:54:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:42 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:42 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Nov 03 20:54:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:44 volumio go-librespot[2020]: go-librespot daemon starting... Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=debug msg="app state loaded" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54: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-gae2.spotify.com:80]" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" 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 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" 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 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=info msg="zeroconf server listening on port 44201" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=debug msg="obtained new client token: AAB/RZ6LU24Q9TRbQGO62I0AQCEpJJfzKM6f9WITpEuLGAcHDtswlqv5si9wiINI3qax59Y7iB/UP5WnBF3ceIgm7LvlM/43swk/kcJ7bk4YQbAMRIfGFh3XFqkFcfM0I5yv0LpZ+DANGLQU5VwomSAuYmQXeTuhPpWgfJ5sS2HCVZs6IHUYOPcc0Y25D6ovKg+yM6MZDL1S62fUHYQpKMifRDtW3pM7aAlr1NT0p3ASxbmXdtRu" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=debug msg="completed keyexchange" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=debug msg="completed challenge" Nov 03 20:54:44 volumio go-librespot[2021]: time="2025-11-03T20:54:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:45 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:45 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34. Nov 03 20:54:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:47 volumio go-librespot[2042]: go-librespot daemon starting... Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="app state loaded" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=info msg="zeroconf server listening on port 40259" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="obtained new client token: AAD57DYI02MTzp8iJVBlTE8GkiRS1K09c5MZyVsJjsWfEqeuEQqZcnd8UGhu9m8fvWmU0XyUgqwE6WsJUZhGABZPtSzLhMrpnIQRiTmInE+fmvCcoAyyJr3xewAiOpwhtBJqyjqjtFKHSjHYCqWXr0syzELSPQS1Q5Lvo7CbUEEab1rUFdtMPfaii2EACyb3ASCyAU6bsEQu1kB+qSZ+1zZWxjS9QBPD84BwNRE0u6o7xR2ezBloeEs=" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="completed keyexchange" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=debug msg="completed challenge" Nov 03 20:54:47 volumio go-librespot[2043]: time="2025-11-03T20:54:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:48 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:48 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35. Nov 03 20:54:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:51 volumio go-librespot[2050]: go-librespot daemon starting... Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=debug msg="app state loaded" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" 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 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" 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 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" 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 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=info msg="zeroconf server listening on port 36263" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=debug msg="obtained new client token: AAAgkevcZv4mvrWdd7Y9Yw+LW/bs4gazVa07NPc8OCpG1s7XXLGF+pzORr+FRoFl1nj6wccR+uNeYlWbdBUV+bS+7XnX07+/13WEJtLlxgea3gjxkYhdjuvOi3zosLdMoESJmnLRNGgxGXrxrZ1N2Mc3aXCYpGjJRjZSYb5OcTdcJOHanPeOrdqCKnKKs8D2pjlYnTbqNBJK4WRGw6nEmOx+TjCfxHqFCT+D5WPTB7ahsvL3HWFw" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=debug msg="completed keyexchange" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=debug msg="completed challenge" Nov 03 20:54:51 volumio go-librespot[2051]: time="2025-11-03T20:54:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:51 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:51 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36. Nov 03 20:54:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:54 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:54 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:54 volumio go-librespot[2061]: go-librespot daemon starting... Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="app state loaded" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=info msg="zeroconf server listening on port 39577" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="obtained new client token: AACXN6+MV6tjCjgH+5ZHwcivzMmxM+lR9D5eBkQBtulsUgWqGUMFAF3YZdgrpbC2qxr6T3DYoA9CH9IfT0moN2sam3MLJc+RVlkvYQs5iQ6jM3TLx09tWh31+tJv+e2ueoQwfs/8tT2TFQClZ+F8fKVMwaxMZ3P2qXjH1MAS0ghevHUxQYhXsq4inCJUtUpkOO3D+hUN0P9B6B/2bGxovoN+//dNtp2PINbxEXWuUbwrrYNWdyXyWqw=" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="completed keyexchange" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=debug msg="completed challenge" Nov 03 20:54:54 volumio go-librespot[2062]: time="2025-11-03T20:54:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:54:57 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:54:57 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:54:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37. Nov 03 20:54:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:54:58 volumio go-librespot[2083]: go-librespot daemon starting... Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=debug msg="app state loaded" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54: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-gew4.spotify.com:80]" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" 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 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" 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 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=info msg="zeroconf server listening on port 36125" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=debug msg="obtained new client token: AAANsVVf5ytfsKMzZceg5GJZhd+L3ukAYmL/KhOvotP4136gyZ/UREsuMErMHavGGHbspsSZYQahYyBefdBYIB+IZFxHGP7gjQxizi1TvAdyvZmLwLPx01btd+aoLfIlr4L5z0pMVs5MHW2Y5zTWhWsY2+Bz7KfM82LW180ML56wOEgzJ56gB+I8wIZot4e3GDHiQbo0tlVWM1LDllLlMGkEipQtBzJVmsEMxw7DYX1+IC/sKuen" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=debug msg="completed keyexchange" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=debug msg="completed challenge" Nov 03 20:54:58 volumio go-librespot[2084]: time="2025-11-03T20:54:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:54:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:54:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:00 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:00 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38. Nov 03 20:55:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:01 volumio go-librespot[2092]: go-librespot daemon starting... Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="app state loaded" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=info msg="zeroconf server listening on port 45763" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="obtained new client token: AACjnhQx6bbBBP6gPqX7woksaaa/h15fNqD23JsehMh+YWKh6d/5erhpHpsXNRxIQUH4IvvNjYzf4fb4ksdsuIMrXxKLgdyi9LeAKVEFk+UfhB/IqnZZMACgP3bUx9AbCP2Wz8x7RlhJcYFWDUJepYdOKVZ2aSqSpC7hFgcFSuLHneqVYU+kXPgLH640YYUqBfoKqpKA/ochdX5lGm+YclE/fD5lXSh77tDlR9FoJeRMJDV0HVNydR4=" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="completed keyexchange" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=debug msg="completed challenge" Nov 03 20:55:01 volumio go-librespot[2093]: time="2025-11-03T20:55:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:03 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:03 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39. Nov 03 20:55:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:05 volumio go-librespot[2102]: go-librespot daemon starting... Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="app state loaded" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=info msg="zeroconf server listening on port 35583" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="obtained new client token: AACCL3MbZ5INm2UjqjKb89UxICf3vZ7EcG7eKqT2fkh9388CiNq0FwwifWk+0oMXwzs8unAd6KIEbfrNRKfcZwRvGykDGR5p4KrHoJ3WtvXKYqleY6bFKvJ9GZk5dcqnQBTb3XHaFWVoKH4+Dc3cNMzJPwchi2C0Pi0kaf5WANnHM6eQGCo/ZOPx8CizKIMCVaLH/aAs3/V52n7qZvxNntdaZOXcDnm/qc5tPa+EwWHMH5OBqnYB" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="completed keyexchange" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=debug msg="completed challenge" Nov 03 20:55:05 volumio go-librespot[2103]: time="2025-11-03T20:55:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:06 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:06 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40. Nov 03 20:55:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:08 volumio go-librespot[2124]: go-librespot daemon starting... Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="app state loaded" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=info msg="zeroconf server listening on port 35925" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="obtained new client token: AAAqEmIHIOoBdu3ETd/2SOkHHe0BMM2e858GZFXidSGBRjHPStnma3epfcB//CWoEMYalrcyZZMDLRlviDSIPwdayu8dRvnvTw0b3NCwZwFuImmOSoIz22OAf1MUbuzUyTyZvKGGveM/2H0j4DfIYae7Dv9PLvxTBaT94PtTpWu37lVMZGxkxW+uvkcIonKu62QtUH+4F5U7ivOiGDcxJpnAN6IgwGLnNzn6pSA6g/ZfQMfRFaTRZMU=" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="completed keyexchange" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=debug msg="completed challenge" Nov 03 20:55:08 volumio go-librespot[2125]: time="2025-11-03T20:55:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:09 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:09 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41. Nov 03 20:55:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:12 volumio go-librespot[2136]: go-librespot daemon starting... Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="app state loaded" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=info msg="zeroconf server listening on port 34179" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="obtained new client token: AADfkJcF35yjvtz+pr6icTg4VS5IatX69usVSfrXaO9gde3l/WxSmxZGfKiqcTgQRCY/+0rkx+LVWyil695EiU/pBcIUohl1HBjpCL7Ey94BrrQ7G8SlRnnQMhCRV96XrVgfIAWpWM7/qoNFQcwhHokpUOzfNO/oaxgEYB0FbbWtvTp2/8HMzqRGEBtE0+cOoQ2FMiY/+iL7DI2n/Vl903OmptUQGx0BK4inWquO0FlA0JSopLIF" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="completed keyexchange" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=debug msg="completed challenge" Nov 03 20:55:12 volumio go-librespot[2137]: time="2025-11-03T20:55:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:12 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:12 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42. Nov 03 20:55:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:15 volumio go-librespot[2144]: go-librespot daemon starting... Nov 03 20:55:15 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:15 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="app state loaded" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=info msg="zeroconf server listening on port 38365" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="obtained new client token: AAAG3sKkbY5/Nc/EJpaNpUgi1Vsl3IpOuv8V9z7A6hTvRbgcUggG67cNVQOfKJQqmKecM3F2glGjiK4l8z8Pa7psgIzRGc8gWReFS6N4F0tfaXdkslkmjPTYVx2EHWPNnxig4Mqjg7hFtfB1fpb9M+eZ1ap0xriwmnNbYySiiarBa5USlsDGU2IEHHy1XxivRAgOrqKY2Itx2A8YBH5lT2M3IazRfpE1mZ1p2+aucJYoLRXFriBwjM0=" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="completed keyexchange" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=debug msg="completed challenge" Nov 03 20:55:15 volumio go-librespot[2145]: time="2025-11-03T20:55:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:18 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:18 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43. Nov 03 20:55:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:19 volumio go-librespot[2166]: go-librespot daemon starting... Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="app state loaded" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=info msg="zeroconf server listening on port 36139" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="obtained new client token: AAB7xdDDBnNtDwJ8SdbX9WRdGlu89V1KgGwqsZrClCx3twdfrioBhMRZoLzSXT4sWTlo1wpa57TMufGGT95dfVYHmv3FDGDIiQWKBE/m92ah4IWZuPdRFiZMGX24Ls4DWK0NT3eGA4zePNLzCtN2h4NHSgY9j7VvUTV79rVTpnAOFTdvdR1o1tQKkRXRpaf6SWHGdIEJ+SMR8Oaxhd79iQtv8P5MNW+Sw8u9ZsBrOQCmIVy+E/hL" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="completed keyexchange" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=debug msg="completed challenge" Nov 03 20:55:19 volumio go-librespot[2167]: time="2025-11-03T20:55:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:21 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:21 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 44. Nov 03 20:55:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:22 volumio go-librespot[2174]: go-librespot daemon starting... Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="app state loaded" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=info msg="zeroconf server listening on port 45853" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="obtained new client token: AAAvIOwIFFQcHgLNQGEpCBZx2SkWUkaPddcYMdx+J7ceNIAIrR2B/wNnWYLeTrLCYXT2uoQ+JhE/hPOb4quVm7tRt73iXJL++b6WWpeHgxK/jif0L/OsSLpb5qZ9LhX1dK6VFa03I3e4F9l1J3Cn95QUwpeC8prtvmb5RMbYulIIe1lr9lZCSJrLz2Kr8cqjb6e4HPL3t+7A9aKVe6qb8kVu+ULxmVv55ZisPCMCpcAfR6BfzCGQFWI=" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="completed keyexchange" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=debug msg="completed challenge" Nov 03 20:55:22 volumio go-librespot[2175]: time="2025-11-03T20:55:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:24 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:24 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 45. Nov 03 20:55:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:26 volumio go-librespot[2183]: go-librespot daemon starting... Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="app state loaded" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=info msg="zeroconf server listening on port 39107" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="obtained new client token: AADi5VcpAl9jaOcW7JPzZflfnqYA0RurUKwiv9dAS1VCYQl8+5SI7y1uO5ugAL2We0LIhCvO5au9kQwhKqS0XRLD73zWmuxQytx+KVOAPom2B5Ml7iqmIF8UlvtaxEp66ayVQsWFhfRXiDaxDcks5lMGUpHCCQEeydy/Nzq3QRJUEr0yciYAfkSf0glVCAUoUhbR3ZdwwOsShxL7zYW1iV24bvHe6Zzm2b45Q7lUQsIwRdS/dSWh" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="completed keyexchange" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=debug msg="completed challenge" Nov 03 20:55:26 volumio go-librespot[2184]: time="2025-11-03T20:55:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:27 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:27 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 46. Nov 03 20:55:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:29 volumio go-librespot[2205]: go-librespot daemon starting... Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="app state loaded" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" 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 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" 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 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=info msg="zeroconf server listening on port 36583" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="obtained new client token: AABlO9P0GfKgrQci0kyoW86Rm7oEfR4F1NZzMcPtCN6aIXdX5VZgxKzA3zGUF/CgkN831YSQbJZ207Kob+gDJOzECOOZTeE/fu0AN2uTy89W5gB4CWk79UEUcLU+GD42sU2PyCXlAP+UbjOtlmkNU/Z9eQ1kOCVB4UejVyiJF1pOzPTkoi5Q+s29G0D1b7mh4gZAIkSlArX1/ueSHWCkUxqM3edbqH1Kk0q/A9W6G83KEYrCUVtkexQ=" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="completed keyexchange" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=debug msg="completed challenge" Nov 03 20:55:29 volumio go-librespot[2206]: time="2025-11-03T20:55:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:30 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:30 volumio volumio[1242]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 47. Nov 03 20:55:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 20:55:33 volumio go-librespot[2216]: go-librespot daemon starting... Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="app state loaded" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=info msg="zeroconf server listening on port 40615" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="obtained new client token: AAC3s3sRnwqVvkKScJVkhyUMgEs173U9lHhbdVC3xtjhl3MRDCGXrdvXtXlkz7DvCMtOtmOmrnI+tA5Kw+o5mL+myZ83VEHcsCbJkATSnQbO1FdwckkK1MYnz7ac1vHZfxe49qhK4oqZx26qjJw1NMNA3049Q/qfvJQYcFA2cxrfBpLH+rUdcJHmosoHYB37dTns2uiomQ1C3BFFql2B/twtz1cBHAOfASGbIHvTE3DOR/9AhY53" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 20:55:33 volumio volumio[1242]: info: Initializing connection to go-librespot Websocket Nov 03 20:55:33 volumio volumio[1242]: info: Connection to go-librespot Websocket established Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="new websocket client" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="completed keyexchange" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=debug msg="completed challenge" Nov 03 20:55:33 volumio go-librespot[2217]: time="2025-11-03T20:55:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 20:55:33 volumio volumio[1242]: info: Connection to go-librespot Websocket closed Nov 03 20:55:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 20:55:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 20:55:36 volumio volumio[1242]: info: Getting Spotify volume Nov 03 20:55:36 volumio volumio[1242]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:55:36 volumio volumio[1242]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 20:55:36 volumio volumio[1242]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 03 20:55:36 volumio volumio[1242]: errno: -111, Nov 03 20:55:36 volumio volumio[1242]: code: 'ECONNREFUSED', Nov 03 20:55:36 volumio volumio[1242]: syscall: 'connect', Nov 03 20:55:36 volumio volumio[1242]: address: '127.0.0.1', Nov 03 20:55:36 volumio volumio[1242]: port: 9879, Nov 03 20:55:36 volumio volumio[1242]: response: undefined Nov 03 20:55:36 volumio volumio[1242]: } Nov 03 20:55:36 volumio volumio[1242]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:55:36 volumio sudo[2252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 20:54' Nov 03 20:55:36 volumio sudo[2252]: 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"