Oct 29 23:50:01 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:01 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 131. Oct 29 23:50:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:02 volumio go-librespot[31505]: go-librespot daemon starting... Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=debug msg="app state loaded" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" 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 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" 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 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" 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 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=info msg="zeroconf server listening on port 41987" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=debug msg="obtained new client token: AADV6mZ1fwdSxpw7xyvMO4lZ763x7QHtNMhY75WeLlI0Fv0LPjfBN4aLBbhqV8ncI3GOnrB3D07ilYU40vButdZupUaM0iuvC/IUMgccYXPnUmddmiQZxTPTRpCuxg8W2MHs/wshzjy+BM6v3Z4PhYlvYHTK2oWYCuH/uJ9XbKLdqRScPDmTFkAHPlBM6YcDMUbUTXnyrcH58heWRonZ1e0SenHcnHEulHrJjXmqPNIox26fdqy17Yk=" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=debug msg="completed keyexchange" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50:02Z" level=debug msg="completed challenge" Oct 29 23:50:02 volumio go-librespot[31506]: time="2025-10-29T23:50: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 29 23:50:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:04 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:04 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 132. Oct 29 23:50:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:05 volumio go-librespot[31516]: go-librespot daemon starting... Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="app state loaded" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=info msg="zeroconf server listening on port 38065" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="obtained new client token: AAB2sR/6Lua+kWWtqV3z2RdxNyN6UnkLXoLjik6F5Tx68ilmzJAmRkQVGRCKocCHEmBZjpBlpZtbXBxurflnuHb9NFrFPsiSMBfMMUAAb8KjDeV33xw1TXwPgpsXdpIO5Z8DmpFaDVndhdi4hoQ1X7KmRbaD+I3EGB0DaFwlWEKGngrl6NEI7XtCSbB530tGnoRPzRKe36r5jw1RlFqOfscxiaFfVU4nxwGy6O0ayqeAaPfyFp9Uqk0=" Oct 29 23:50:05 volumio go-librespot[31517]: time="2025-10-29T23:50:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:06 volumio go-librespot[31517]: time="2025-10-29T23:50:06Z" level=debug msg="completed keyexchange" Oct 29 23:50:06 volumio go-librespot[31517]: time="2025-10-29T23:50:06Z" level=debug msg="completed challenge" Oct 29 23:50:06 volumio go-librespot[31517]: time="2025-10-29T23:50: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 29 23:50:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:07 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:07 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 133. Oct 29 23:50:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:09 volumio go-librespot[31538]: go-librespot daemon starting... Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=debug msg="app state loaded" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50: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 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50: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 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50: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 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=info msg="zeroconf server listening on port 38355" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=debug msg="obtained new client token: AADGQY8h8iZ+ZdxKMaWg+rPGhecKa6uk2jpLtTBlID4+KbN3eGBQxGa/HVHx8bBZLsEcUmcxJqdd9SFnZtAMg6SGIi+7D74SE2U7yZ4rf72e4krBpMZzPl2rZztEhDSCMBxTzHh9qmt4LaFemWdDw+ICktwSQKfcUpBBv9TsvZ/xNQrhCgQ7gpfyFfxVoQ8e6hRki71LBFetgVCe/IfjVpyZD/w4ywIVcT6g75NhtXtDPH84+zp7wpk=" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=debug msg="completed keyexchange" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50:09Z" level=debug msg="completed challenge" Oct 29 23:50:09 volumio go-librespot[31539]: time="2025-10-29T23:50: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 29 23:50:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:10 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:10 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 134. Oct 29 23:50:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:12 volumio go-librespot[31547]: go-librespot daemon starting... Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=debug msg="app state loaded" Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50: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 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50: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 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50: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 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=info msg="zeroconf server listening on port 43587" Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=debug msg="obtained new client token: AAANtC2Ac9eRMeaS2sUBOVqqd1DHuiVEg6WDsw/Smez7pVaSH3mUWP1ppTNuOqLAYmawXEwRU5Qtsj5wgrKMHJ2heuCiLGQz1zF//X7gBLL+AqiciTk9iz++9AF4C6mosFBeFE24aj/3pbpMWtkfiM67lG4yV5WV0IviSpB6d4kmwnTtQE1Tv3WgYthOW82Ddo+25+tmy4Ud2SsSK0w7arp/n87QVC0lanL5maojCCVqLOVeHwxh5Ps=" Oct 29 23:50:12 volumio go-librespot[31548]: time="2025-10-29T23:50:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:13 volumio go-librespot[31548]: time="2025-10-29T23:50:13Z" level=debug msg="completed keyexchange" Oct 29 23:50:13 volumio go-librespot[31548]: time="2025-10-29T23:50:13Z" level=debug msg="completed challenge" Oct 29 23:50:13 volumio go-librespot[31548]: time="2025-10-29T23:50: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 29 23:50:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:13 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:13 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:16 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:16 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 135. Oct 29 23:50:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:16 volumio go-librespot[31555]: go-librespot daemon starting... Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=debug msg="app state loaded" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50: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 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50: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 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50: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 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=info msg="zeroconf server listening on port 45053" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=debug msg="obtained new client token: AAAyPzIUW/tEe2VCwz0RUte10cuIkYFkLt+QxGTd9GNgJQXq7VCwaEC9ZmRLkuU6/rYKuSqMJjzDlCl3Ak+Peza91gD2pLoYjjK1TDaT8LonOXKbBuAFhMRfND2wtQN9zmnS55Qwz57jD1Ysg2yM/cHYIRqh1XQOfy0Wm2a3gVA6uRZcvbwji3bfg7iStZXqSTn59CQIo+Ohb9DwhGE5tCnge37kVqtzFVPSH3rMdiAOlivUzuo1MlA=" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=debug msg="completed keyexchange" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50:16Z" level=debug msg="completed challenge" Oct 29 23:50:16 volumio go-librespot[31556]: time="2025-10-29T23:50: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 29 23:50:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:19 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:19 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 136. Oct 29 23:50:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:19 volumio go-librespot[31578]: go-librespot daemon starting... Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=debug msg="app state loaded" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50: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 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50: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 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50: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 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=info msg="zeroconf server listening on port 34101" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=debug msg="obtained new client token: AAChIktMduclspCxQC1v0A+8ccetotlBF4hqdXfca1mu30KmkoEQmq9IybMs7TIyQaWXunkWMVb0i0SuL7OCaYo1WggS+slxzQGN7gx83KMlRqgLGpsE20e1qgzeJb4DEeJHh5JAZE85O4C1+D4q0GfStBo+VzSGGjx1cekPDvkWG7uIjyDET3B1ltYr+kewhaCza6LNLIgYd4wS4NVEKQyG+DET91Vspga0v4gKo9a2RcxrwZREgEw=" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=debug msg="completed keyexchange" Oct 29 23:50:19 volumio go-librespot[31579]: time="2025-10-29T23:50:19Z" level=debug msg="completed challenge" Oct 29 23:50:20 volumio go-librespot[31579]: time="2025-10-29T23:50: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 29 23:50:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:22 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:22 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 137. Oct 29 23:50:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:23 volumio go-librespot[31589]: go-librespot daemon starting... Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=debug msg="app state loaded" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50: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]" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50: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]" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50: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]" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=info msg="zeroconf server listening on port 44849" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=debug msg="obtained new client token: AAD405eVZaQAZ91lETIUEM7vsgrJPn1e9/IMNirL/xo8P34KJ0krEyncgOps5aJBMc3vA2hG1vNfXwtWd//XhWm4567lWjan6HLuMS1ks1qmdRGicViAeq3KtWp3LozL6GbnhE4LlXJYYaIVh9qEZRs0ImRXpVC6A60LNArDMI6MVgUUlNVRsfX9xukDMFREcWvBy5VOQwa5PW7ni8vedFUKWt//dCaDhNGLwx5TSyBzrKh77EXY/c0=" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=debug msg="completed keyexchange" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50:23Z" level=debug msg="completed challenge" Oct 29 23:50:23 volumio go-librespot[31590]: time="2025-10-29T23:50: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 29 23:50:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:25 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:25 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 138. Oct 29 23:50:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:26 volumio go-librespot[31598]: go-librespot daemon starting... Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=debug msg="app state loaded" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50: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-gae2.spotify.com:80]" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" 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 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" 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 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=info msg="zeroconf server listening on port 40855" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=debug msg="obtained new client token: AAA8rHtw3nPuD9lEG6BMYA4wZzrv8FNzibL7P3vu1MxYyPbKODfiUNSOtzX6fyR/QlqhCDjJg/8w1UfFR3CKHU+HmSe6vfC0wCRBWp8yAw3p95+uqj89YeEU7wJ7MlyupFR1VkqW8CzG5o3DMrL8f3we6eQuhAggHLg9gTy5pdXBfoT69Z01C9fyuj1M/2i0mrt0/zjWKfZxsAMhmPxyQNgZqkZSxW0obpzPACSU9cvTKBqaikhpcdk=" Oct 29 23:50:26 volumio go-librespot[31599]: time="2025-10-29T23:50:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:27 volumio go-librespot[31599]: time="2025-10-29T23:50:27Z" level=debug msg="completed keyexchange" Oct 29 23:50:27 volumio go-librespot[31599]: time="2025-10-29T23:50:27Z" level=debug msg="completed challenge" Oct 29 23:50:27 volumio go-librespot[31599]: time="2025-10-29T23:50: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 29 23:50:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:28 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:28 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 139. Oct 29 23:50:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:30 volumio go-librespot[31620]: go-librespot daemon starting... Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=debug msg="app state loaded" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50: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-gae2.spotify.com:80]" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" 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 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" 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 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=info msg="zeroconf server listening on port 44883" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=debug msg="obtained new client token: AACohNU/GxnATYkzNcB/C+h9gAJAEjqU/FMEmYUHcB0pue2m/H5aoCrMI6zsjOMPl1HvowEA42p7pMw+jAIxOoIDXr360dMSh40Vv3AlnrBWb0mVPLu+JnyEStRPFp2Yo+KnAUPpXvowz0UczUnILA24+Tjtdw4TxGJvxPt0Wvkod2vGtXBNCjOMxWo0lR1vQz1pObdByCe2N7viajfErUvLQWbOPChXyRq+Ipf11JAwkmr3r3+bZkM=" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=debug msg="completed keyexchange" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50:30Z" level=debug msg="completed challenge" Oct 29 23:50:30 volumio go-librespot[31621]: time="2025-10-29T23:50: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 29 23:50:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:31 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:31 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 140. Oct 29 23:50:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:33 volumio go-librespot[31629]: go-librespot daemon starting... Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=debug msg="app state loaded" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50: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]" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50: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]" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50: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]" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=info msg="zeroconf server listening on port 45657" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=debug msg="obtained new client token: AADNKzFFSvsxf7tnh98ZobuxKnnqPgkCQBMkGxR3kcitjSUM9IL2IYjScCU9fPcgm56s4fSVutBbi8lg1cx0gW56T83lHEculA4DGto40mTJC5tNuUicCV8rMJi5hcveaSv+ge9uTPDqPFH0QIwEouaxy2eb7W2291UJ61BN6sUbzrsV/8RluLxJHh+M+ZZVbWyx/bttjipxUIp9bbFWNaSfivsjH3/LSmrDeoGOW/k/tP/TUfEhJRo=" Oct 29 23:50:33 volumio go-librespot[31630]: time="2025-10-29T23:50:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:34 volumio go-librespot[31630]: time="2025-10-29T23:50:34Z" level=debug msg="completed keyexchange" Oct 29 23:50:34 volumio go-librespot[31630]: time="2025-10-29T23:50:34Z" level=debug msg="completed challenge" Oct 29 23:50:34 volumio go-librespot[31630]: time="2025-10-29T23:50: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 29 23:50:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:34 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:34 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:37 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:37 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 141. Oct 29 23:50:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:37 volumio go-librespot[31637]: go-librespot daemon starting... Oct 29 23:50:37 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=debug msg="app state loaded" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" 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 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" 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 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=info msg="zeroconf server listening on port 40041" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=debug msg="obtained new client token: AABvfb7EHUqhFe6cs9stKmvkI8m41uCmdw8qHx0AKeXRKBfRdh2x6pPeQ9KDHLMdqH6yEbPkeJWoL+xGAC3uns+FCccTRWf83QT8v1jVJESdIl9L8sZjmdUaF7FF3NcG3eONjDbKT6N9bHjWdSpdlMne3WQNCYx0qeMfmhhv/BCSLFvnt5NHgkF0myi5uG6S3M/rGiTimsVDN/Zxm+sMgl4/RXhfeElvFm/C5+zEjIdnh8jq/3NrWcU=" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=debug msg="completed keyexchange" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50:37Z" level=debug msg="completed challenge" Oct 29 23:50:37 volumio go-librespot[31638]: time="2025-10-29T23:50: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 29 23:50:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:37 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 29 23:50:37 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 29 23:50:40 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:40 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 142. Oct 29 23:50:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:40 volumio go-librespot[31685]: go-librespot daemon starting... Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="app state loaded" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=info msg="zeroconf server listening on port 44021" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="obtained new client token: AACpCCd9avebAUSv722GdOnUtMUana0h3hIxWUI7dMzupYCo2ZmAxI5CcZqOV63TcYi7vQgW4jXZJUqKK1bKhdFXsB6UGX4bo3jPVk3Oki4Rwccq/9bpPEKiCYySYrITXv8VqlsMGhRjBCz+FGxf3rBhpD9c1w9dMV4BfBZ8kp6akcITBGcpTfT1Agc40PCcgKOM0vhimdCe2/xukQ6IluBj5ns9LIHQxmdkGiI3X9oEG/FAebVNDGs=" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="completed keyexchange" Oct 29 23:50:40 volumio go-librespot[31686]: time="2025-10-29T23:50:40Z" level=debug msg="completed challenge" Oct 29 23:50:41 volumio go-librespot[31686]: time="2025-10-29T23:50: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 29 23:50:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:43 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:43 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 143. Oct 29 23:50:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:44 volumio go-librespot[31697]: go-librespot daemon starting... Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=debug msg="app state loaded" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" 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 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" 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 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" 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 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=info msg="zeroconf server listening on port 38599" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=debug msg="obtained new client token: AABn1rhSE/r/CyBifCiLE4z+k2CC7k8IETQ4qGEBRUcXjZKm+Pw3Rxcr/s1i/M79eVLbWO/rESM2Yqv1LdUySOrzlJ/7vM0LUBMU8a8V1NZinVyvriunGdfltFEkfQEjiu/6zObOqD+xPB72OwWLGj4q16ZfWXozU5lOspAbCJ5dRj1lwkruBaDd0DpTlpE/YneWVpwfZGgJFf7/Gd/JUgOo8OWseCqPS2ZZib99KIrs3H1Faawx" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=debug msg="completed keyexchange" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50:44Z" level=debug msg="completed challenge" Oct 29 23:50:44 volumio go-librespot[31698]: time="2025-10-29T23:50: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 29 23:50:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:46 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:46 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 144. Oct 29 23:50:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:47 volumio go-librespot[31720]: go-librespot daemon starting... Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=debug msg="app state loaded" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" 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 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" 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 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=info msg="zeroconf server listening on port 45663" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=debug msg="obtained new client token: AACnOoG8mu9R9bnLZ3RUF0btSb/WOp+9EErI5+DcKYplqKmIdbBzCEZBuKgx9oOXQM6lmMehM7uB3vmitnIcBna8cM3jF35HGRK5HV+DuXmZWoJNXXqBoNxOMjVF25aqe5S3PJfLNpUm9HvLwM67BLr7wKW5DWKSPpsNoSUeS23zXppVekuRcMIB4I3b5ye62dYVpJ1sZcv+Q6+1IAGLaOQEUpaw20vUxJqhCdEpd7/eBhrjH3pcQgo=" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=debug msg="completed keyexchange" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=debug msg="completed challenge" Oct 29 23:50:47 volumio go-librespot[31721]: time="2025-10-29T23:50:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 23:50:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:49 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:49 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 145. Oct 29 23:50:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:51 volumio go-librespot[31729]: go-librespot daemon starting... Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=debug msg="app state loaded" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50: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-gae2.spotify.com:80]" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" 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 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" 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 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=info msg="zeroconf server listening on port 45153" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=debug msg="obtained new client token: AABaPVX3F1viezFHoKt47nmp5yaihua9l7Ysmok4I+/zle9tP6AfpJmeIOw2ETzWEVUWAYEKur9PyPD19NYkoQIM/FI81jjatgkOdULfyCRTe6KFrZTVSDKN5mQ5zssSKgTwq0GFWexr+xg/ojpJbstIMXOShSW+w3XmLgh4DFTav+IunFtA1goBPEku5ZQOpmDwFSz0QCw2uQuEwh1xJkORQ+7tr9V0X6ob/Fhb0dD0tFFhAzR2" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=debug msg="completed keyexchange" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50:51Z" level=debug msg="completed challenge" Oct 29 23:50:51 volumio go-librespot[31730]: time="2025-10-29T23:50: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 29 23:50:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:52 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:52 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 146. Oct 29 23:50:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:54 volumio go-librespot[31738]: go-librespot daemon starting... Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=debug msg="app state loaded" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50: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 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50: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 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50: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 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=info msg="zeroconf server listening on port 34543" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=debug msg="obtained new client token: AAAfmohRciXRvHDGn1HiozJ4gJgyQQ8bq1zspOrIIcmdlHWakH/aFLb4aCF/MIceERKOelmMaV0S2NPrlPR0swoBPdtfAJNFQh8yyWsEGjiL+L8eShvbA3eiHyIuV7/U8zEfE+GtJbaVAOBwz6vpn3/HTlEvUYtxbr4XJ3jns5eeoYm8Be194feOg0VUHJalqV3WmBB1pyN8wm6Y3Bs/fDKwp63Co/uJ0VEZW8VpzmBunubziWAtI8Y=" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=debug msg="completed keyexchange" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=debug msg="completed challenge" Oct 29 23:50:54 volumio go-librespot[31739]: time="2025-10-29T23:50:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Oct 29 23:50:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:55 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:55 volumio volumio[30646]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:50:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 147. Oct 29 23:50:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 23:50:58 volumio go-librespot[31761]: go-librespot daemon starting... Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=info msg="running go-librespot 0.4.0" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="app state loaded" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 23:50:58 volumio volumio[30646]: info: Initializing connection to go-librespot Websocket Oct 29 23:50:58 volumio volumio[30646]: info: Connection to go-librespot Websocket established Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="new websocket client" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50: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]" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50: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]" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50: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]" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=info msg="zeroconf server listening on port 41305" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="obtained new client token: AABo8PgdbjFd1M8Rtb6MABpdnN0JRvwwPmcy6P3IcdT64hx2eqf8A/QmzO2SyOq8B1QPKQkuZ7eI+E6eRbI2B2kiEC6SIMwY/hifp1WQRT1+OgHsneNyXkixseqyP/GnkS1j1sT4T82rwL//ltIDK5cSUZiKEvdSgpCtsV2+85s4fTHFg5U7XvVdn7RYO+IbJ7tNr46/D6O40JQOQMfq35Jl5O+JYo5BCDCDmsAT1Zh6DUbvIkjj" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="completed keyexchange" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50:58Z" level=debug msg="completed challenge" Oct 29 23:50:58 volumio go-librespot[31762]: time="2025-10-29T23:50: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 29 23:50:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 23:50:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 23:50:58 volumio volumio[30646]: info: Connection to go-librespot Websocket closed Oct 29 23:51:01 volumio volumio[30646]: info: Getting Spotify volume Oct 29 23:51:01 volumio volumio[30646]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 23:51:01 volumio volumio[30646]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 23:51:01 volumio volumio[30646]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 29 23:51:01 volumio volumio[30646]: errno: -111, Oct 29 23:51:01 volumio volumio[30646]: code: 'ECONNREFUSED', Oct 29 23:51:01 volumio volumio[30646]: syscall: 'connect', Oct 29 23:51:01 volumio volumio[30646]: address: '127.0.0.1', Oct 29 23:51:01 volumio volumio[30646]: port: 9879, Oct 29 23:51:01 volumio volumio[30646]: response: undefined Oct 29 23:51:01 volumio volumio[30646]: } Oct 29 23:51:01 volumio volumio[30646]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 23:51:01 volumio sudo[31783]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-29 23:50' Oct 29 23:51:01 volumio sudo[31783]: 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"