Nov 01 10:41:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 01 10:41:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:00 volumio go-librespot[17710]: go-librespot daemon starting... Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="app state loaded" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=info msg="zeroconf server listening on port 41779" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="obtained new client token: AACi+PgW34p1CgHxFZLriThfgsNXFsv1kyEOV8VIbFTPh1YrJ8DYzwKqTdzoJ2vuCG5/wBZ1cqX3YRc97A1o7ZLBjcZqSmozwco2O+/7JhuDs3p87+/BHoOhzRchC6otx0A/wkk4K4MYrU4WL2vQbsnSa5tjGz23sF5Zrh0onaCupUZQxupIk61YuyiHF1Ht6qhV6H1miv8A9TsmjSG0E6eIjPbbElFpiBQfsFKgoie+bNjB512l770=" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="completed keyexchange" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=debug msg="completed challenge" Nov 01 10:41:00 volumio go-librespot[17711]: time="2025-11-01T10:41:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:01 volumio volumio[17253]: info: BOOT COMPLETED Nov 01 10:41:01 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:01 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 01 10:41:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:03 volumio go-librespot[17734]: go-librespot daemon starting... Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="app state loaded" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=info msg="zeroconf server listening on port 34567" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="obtained new client token: AABaGPKhTq5xvDVSc8NkOt2GvAZzaGS9ONFwyeIOf+qcoQvuTmMc2xvybzhd5DIULiXGbsZpn/PRdCN/+0emcyplj8TAUo6OlqUH7X5KTtcr3Z8bvWvN3CtBlV4qyman4o8qATvOt0uaODnILbGcnCIgB6qggLzzIDOtk14I+CFlxbLRrM031mVTdXKeqLiCIWZVZjSN7NR/8vzfBsmastekwICVkZI51D9e4DVFI+VdkGv0tdGM4aw=" Nov 01 10:41:03 volumio go-librespot[17735]: time="2025-11-01T10:41:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:04 volumio go-librespot[17735]: time="2025-11-01T10:41:04Z" level=debug msg="completed keyexchange" Nov 01 10:41:04 volumio go-librespot[17735]: time="2025-11-01T10:41:04Z" level=debug msg="completed challenge" Nov 01 10:41:04 volumio go-librespot[17735]: time="2025-11-01T10:41:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:04 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:04 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 01 10:41:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:07 volumio go-librespot[17742]: go-librespot daemon starting... Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="app state loaded" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=info msg="zeroconf server listening on port 44583" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="obtained new client token: AADYTWKE/C83H0UjyT0tPh0Y+Q6t8NpL8+Mc2R1u0nXGAdTJ9Z6lhsc3yYMe/J5j9DQ/t4Vad7O13YYRcy2NDD4UhSbIt6eklWRHIkIHUExdYDNeJun3aQq1jOFrPAU+yG39kOYzw9234lr0gTOMSEuDNKd27YBa5e68bDb7wFFgwztqbN5Ld49v2OS4hYeGMoOOyH2Ntv+By+RPIaxzn+TVRBVdgdeoIxupuAn7xdxMD2IhKoFyQwc=" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" 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 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="completed keyexchange" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=debug msg="completed challenge" Nov 01 10:41:07 volumio go-librespot[17743]: time="2025-11-01T10:41:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:07 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:07 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:10 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:10 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 01 10:41:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:10 volumio go-librespot[17753]: go-librespot daemon starting... Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="app state loaded" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=info msg="zeroconf server listening on port 36233" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="obtained new client token: AADZo0ZyKI0btjkxxgyjm8EuND1MNdKLbSWSLGRsCsjSGXmEFsOxbh2tpk4Ktfa7xo5asFfQGjoBzZHa9WOfykhy87EYSA4hib2TQuUFGr36/1J65u3JFD4e+5aqDH/sooHnteUeaMqHvIVNHxTZ0PwP65d3GijPJoRtWYo44+epnPJMRDwWcHH2BhwB39jVu63XgqvBzYv2q+BhuQxWQI9ea5n2Sc3v/lC/lYOCEal7euvke5q+u/M=" Nov 01 10:41:10 volumio go-librespot[17754]: time="2025-11-01T10:41:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:11 volumio go-librespot[17754]: time="2025-11-01T10:41:11Z" level=debug msg="completed keyexchange" Nov 01 10:41:11 volumio go-librespot[17754]: time="2025-11-01T10:41:11Z" level=debug msg="completed challenge" Nov 01 10:41:11 volumio go-librespot[17754]: time="2025-11-01T10:41:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:13 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:13 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Nov 01 10:41:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:14 volumio go-librespot[17775]: go-librespot daemon starting... Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="app state loaded" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=info msg="zeroconf server listening on port 37993" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="obtained new client token: AAAmr4Fo7hJGAWd3S2hpD+DL3KyCWmdynFMVPJLwIqFs/6IDbNGmiG69xwq/o5Y1wSZq2xQrpdHL24iM8kAKDi6JFHRXHtnxBGt0V4oMGmW9o7Lx+/zSJxeyiwvLPcwOFF0DGckOZ7j08qDqnXxdVZYENw5kzeRuMsnAt8akry0qKuTdINNj0/RrVpyIM5c7KQ/FSppXpNOvwytJnY7N7kS/49SUc3irL9FPcybHHXYeic/Oav9BRMY=" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="completed keyexchange" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=debug msg="completed challenge" Nov 01 10:41:14 volumio go-librespot[17776]: time="2025-11-01T10:41:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:16 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:16 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Nov 01 10:41:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:17 volumio go-librespot[17783]: go-librespot daemon starting... Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=debug msg="app state loaded" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=info msg="zeroconf server listening on port 37467" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" level=debug msg="obtained new client token: AABKT88XXRF4zh7qzTtMkt/FOQRW8oNkuSjNvi+P0FiLDcECfJxwYMDIsPzqegSd61UuB3BfYKYehYc8mGFdy28oz1TJZAbbWHs8f5xesRkQno1NxaDrWlbxj88X8rcv+cyof0Tl82uBODTizgjrz0v9y01ijPD1vc4lB3T1FFNzO/gmFs5seo0ft4jsylUH0Ct8/eO2CqCAsbrmriLawjFgt6i4Y+SuhwyvRFyyX3Wak8ZPVX/9Pjo=" Nov 01 10:41:17 volumio go-librespot[17784]: time="2025-11-01T10:41:17Z" 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 01 10:41:18 volumio go-librespot[17784]: time="2025-11-01T10:41:18Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 10:41:18 volumio go-librespot[17784]: time="2025-11-01T10:41:18Z" level=debug msg="completed keyexchange" Nov 01 10:41:18 volumio go-librespot[17784]: time="2025-11-01T10:41:18Z" level=debug msg="completed challenge" Nov 01 10:41:18 volumio go-librespot[17784]: time="2025-11-01T10:41:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:19 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:19 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Nov 01 10:41:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:21 volumio go-librespot[17792]: go-librespot daemon starting... Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="app state loaded" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=info msg="zeroconf server listening on port 41255" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="obtained new client token: AAB55vmCdnFblQxqB2h0KCUZoJlay/1TndYvONTXQdwfpiKsM2ISdiKeYoaaiYw9Sv9q6C2yooJ08BaPn+7Uo+tyOqZjFHSuVnAr94l8rLoCe+2y+kMc5nI3wkNmaRhmPG1Kt5lflqDiYnLkatLTqDbs4S0QMJzTo7i0sNJYPMpvQ7HLrV7gCwxv0uZNvzi9qBkjjFw6os4d+zWipSUQ5obaC8QlZTuFsCxlhMrjiwftPxGovWvz8cU=" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="completed keyexchange" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=debug msg="completed challenge" Nov 01 10:41:21 volumio go-librespot[17793]: time="2025-11-01T10:41:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:22 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:22 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Nov 01 10:41:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:24 volumio go-librespot[17814]: go-librespot daemon starting... Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="app state loaded" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=info msg="zeroconf server listening on port 40039" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="obtained new client token: AAD/S6Er6hV2LPB5GYKRWbewnpM0zCRylz93t/BC/30dCyRUAGvNb4BY/wrP8pA0Y7dxnzx0X7TX1vyHMQNQRzyeU6ktu0M4TluiWE9JKw9SNSgESNmy4AATD5e6zvLQoCOsNGL1iwHAPb45mlRhB0OOrEMK/bPSQf3k0JX8GMbBJvKU+NHcbODu91xniM0Kh9jxFe+tmGabhMQf8FsrgizlLhoXXrVQ3FCmxu8z8CILbAHcEF5DRjs=" Nov 01 10:41:24 volumio go-librespot[17815]: time="2025-11-01T10:41:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:25 volumio go-librespot[17815]: time="2025-11-01T10:41:25Z" level=debug msg="completed keyexchange" Nov 01 10:41:25 volumio go-librespot[17815]: time="2025-11-01T10:41:25Z" level=debug msg="completed challenge" Nov 01 10:41:25 volumio go-librespot[17815]: time="2025-11-01T10:41:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:25 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:25 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Nov 01 10:41:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:28 volumio go-librespot[17823]: go-librespot daemon starting... Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="app state loaded" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=info msg="zeroconf server listening on port 44271" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="obtained new client token: AACOENlPwWfdJsWETu/2CXoSJfuy9hR8GgXk2hc1mxH8Qgf6KdaU7prxq1RWPR2qkhkL3DMGKRzkvxerrQzmwLtIpLIa/AsEuETqrfis3RdW1u0rwlTI1wGm9uOkAWY47dxxeb4zOlElhNil89/1UycSqaKZ/2cGAZJahV7RmWXqh/Lua33uaE2u4lMwdUuaFLrkEw/oPKmzWX95G81aDLjtooYrgpKM5xrJlXpwB8NiCeDsTYSWSSQ=" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="completed keyexchange" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=debug msg="completed challenge" Nov 01 10:41:28 volumio go-librespot[17824]: time="2025-11-01T10:41:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:28 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:28 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:31 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:31 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Nov 01 10:41:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:31 volumio go-librespot[17834]: go-librespot daemon starting... Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="app state loaded" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=info msg="zeroconf server listening on port 33255" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="obtained new client token: AACbBBmMcrrufnKIVTx++zu+0d7ylsOy+DVamAgnG8v/nCIGsra46Hx0xgvv8KnJ9PfG80lwqI4TOrotAqhS7vNyFBjW7/r3tT/AlKoyMg5U3jV363AaJamYpwa3iO4K1ua6NRuGij/eHsp+4OPhP1qJzbCJFMVt2ykxijyvZTFkSsRuAK9TuqgGO6KjVBeHnxq+y9J1dn4uELQqYFAagDeSkCqVRbZJqTDAGtFfpvT36XP5KSTugoA=" Nov 01 10:41:31 volumio go-librespot[17835]: time="2025-11-01T10:41:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:32 volumio go-librespot[17835]: time="2025-11-01T10:41:32Z" level=debug msg="completed keyexchange" Nov 01 10:41:32 volumio go-librespot[17835]: time="2025-11-01T10:41:32Z" level=debug msg="completed challenge" Nov 01 10:41:32 volumio go-librespot[17835]: time="2025-11-01T10:41:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:34 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:34 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Nov 01 10:41:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:35 volumio go-librespot[17856]: go-librespot daemon starting... Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="app state loaded" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=info msg="zeroconf server listening on port 36743" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="obtained new client token: AACcdcqVyu3DcBL6MLO0Htq+fCWUGJvrFH38NEgEdMkOSgeZ+WhxGUWFpS7UsaVk2Fm5ZLdPpRwCXEOGUof/YuVi+NZ8EVwBKmq1/8jyiOUS0CXhFiqIs42Yx5/tMTo9qP5NA2CnHdYQlnWENsxma4JOJjNEZWYaWt4v1dULDbLsmDDZuAfLduJZ3fnyM8MTOknko2sujZ8gwjmXuDlsyA7f+k82UGUe1h2dMnOUib5MyA2Kas6LcBg=" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="completed keyexchange" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=debug msg="completed challenge" Nov 01 10:41:35 volumio go-librespot[17857]: time="2025-11-01T10:41:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:37 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:37 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Nov 01 10:41:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:38 volumio go-librespot[17864]: go-librespot daemon starting... Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=debug msg="app state loaded" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=info msg="zeroconf server listening on port 42355" Nov 01 10:41:38 volumio go-librespot[17865]: time="2025-11-01T10:41:38Z" level=debug msg="obtained new client token: AADJn6vew4jrzgLqJl88A/yY5bshbRkDHikXJoJNspiOnjqajx0pIfBp37T4FUExzdk/d22B3Oa1JGzhzCpTIsmBfI4d9TqhaKvXUcEV5LrO0F1QGizSjpHmNP3Fwev3hp7MclyTwS2uHT2Q4xy1NQnme9A9VKnDkSstQPS5RJ2W1OkgXwLWzwnodqhbUiYjKVfKn+F2CtyRDOpxfla3wh4OwVjlWiyhQsV8CoRtCfrNTlYtFgS5iEM=" Nov 01 10:41:39 volumio go-librespot[17865]: time="2025-11-01T10:41:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:39 volumio go-librespot[17865]: time="2025-11-01T10:41:39Z" level=debug msg="completed keyexchange" Nov 01 10:41:39 volumio go-librespot[17865]: time="2025-11-01T10:41:39Z" level=debug msg="completed challenge" Nov 01 10:41:39 volumio go-librespot[17865]: time="2025-11-01T10:41:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:40 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:40 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Nov 01 10:41:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:42 volumio go-librespot[17873]: go-librespot daemon starting... Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="app state loaded" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=info msg="zeroconf server listening on port 38995" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="obtained new client token: AABQg8EDEthfKirCkK1/PbRkCWR/gVR1vdJGA0JMBn9TPa5tWqkD7a+PqhQ3mvVcpheozMwYZNyXdRlfrfYP7cJTjiGvPAmQB3VfhqeWtP++YvXMqRwoO1cMf3Jde3WrbRIpaXaisTtPRuawBrsVle0iQTs6sMSzpqi2j3Z5K9dK4fVLKISXp8bugmcGFkkkL3B/P3NZk0AqtlHI5MUF0+hBk/tnTpGQ2ubXDLoV3epjNWua4IQVB30=" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="completed keyexchange" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=debug msg="completed challenge" Nov 01 10:41:42 volumio go-librespot[17874]: time="2025-11-01T10:41:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:43 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:43 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76. Nov 01 10:41:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:45 volumio go-librespot[17896]: go-librespot daemon starting... Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="app state loaded" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=info msg="zeroconf server listening on port 42835" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="obtained new client token: AACr7nLJF5xeefmR68K50B8C2rxQl3HOsCjYxMHFszOVxeYArq+gvUtbo2TtHOMpaLxbqRv/ogoOxbDBkvsZA5inkk4IPZ4MRcNn33TKPF2T8xJ/U+NNIMmbtca+4cN0eEGJ2DZnoJTaybjSLOfqCYR/EFJT+aQLPWB8G7VVhID0yGXxnv5Fs6wydosECRQW35gd7P9QU+2/VPBsPkkxc4fjIYYodLkLXQavyECZBAVCKV+s5qKe9G8=" Nov 01 10:41:45 volumio go-librespot[17897]: time="2025-11-01T10:41:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:46 volumio go-librespot[17897]: time="2025-11-01T10:41:46Z" level=debug msg="completed keyexchange" Nov 01 10:41:46 volumio go-librespot[17897]: time="2025-11-01T10:41:46Z" level=debug msg="completed challenge" Nov 01 10:41:46 volumio go-librespot[17897]: time="2025-11-01T10:41:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:46 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:46 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Nov 01 10:41:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:49 volumio go-librespot[17907]: go-librespot daemon starting... Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="app state loaded" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=info msg="zeroconf server listening on port 43827" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="obtained new client token: AABORQSwUk95vNPcsY478CpcXsFOYTHXCNbidsxMeO2jG4Bc9lzpo/ejuYP1ZxE2H1ZLVjXbNA93xRrC50w5jh1Fc1pHSCSq3LN7X5401xVPaHywmSsnHOZtHHMDSwDalBN9XjTVnRwdFrD6Pj1vBN0w+kd+fBQYK+ZUAw3gCwQ7Mf3Y/S8jYasH4wDMfrEr0dIuIo1Vq5/SvYQAnKOFST3+sABWpBYugJkJ/UljTnZGH1g/gbtv8iI=" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="completed keyexchange" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=debug msg="completed challenge" Nov 01 10:41:49 volumio go-librespot[17908]: time="2025-11-01T10:41:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:49 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:49 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:52 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:52 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78. Nov 01 10:41:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:52 volumio go-librespot[17915]: go-librespot daemon starting... Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="app state loaded" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=info msg="zeroconf server listening on port 38515" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="obtained new client token: AADpQcxh3Mfo709F7XWZyYDlHardbkXhcoOyHxwvfdzwjZVWDCpIbfSc+MoiOXI1kzfNH6To1ijZCmV20uFv2VQq0wOyXJ0LMtNwKXtb3uH+58XGJZDi2xryrfsOC0iEolT4oVW1qvQDlXzA/uqgTiGvagdiaLvjXrupWPY8Nbg2SzvrKpXcazQQxISw0QY3ScFdWxPVHwVzBrXeU9dS2S/EXyIcaW6Vm/AJk3rCgaZAZ0VypQZ4Q5g=" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="completed keyexchange" Nov 01 10:41:52 volumio go-librespot[17916]: time="2025-11-01T10:41:52Z" level=debug msg="completed challenge" Nov 01 10:41:53 volumio go-librespot[17916]: time="2025-11-01T10:41:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:55 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:55 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79. Nov 01 10:41:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:56 volumio go-librespot[17937]: go-librespot daemon starting... Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="app state loaded" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=info msg="zeroconf server listening on port 43863" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="obtained new client token: AABXN933T8OfWzEXpdkzs7f7eMY/b0lUtKg4xMbAzxS90Rwv6ojeEOtSFUdXYQBCSnmevSu1Skx09KwKBVyfw7vUmJbm88deQuo4LSu3Z7Rg6clt32XHat+bKtPE8Q/5+I+lNcwvuBfq8tUIcPgf3n3wCkvLo563NsGab9FnG7bJjgoWwsImCR7ZSekQfVNb/JLHXnmypmUx2Hqpo2uXxOnUMqQAoDXNBfHoD4sfAT1GWohMq7xGkQk=" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="completed keyexchange" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=debug msg="completed challenge" Nov 01 10:41:56 volumio go-librespot[17938]: time="2025-11-01T10:41:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:41:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:41:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:41:58 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:41:58 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:41:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80. Nov 01 10:41:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:41:59 volumio go-librespot[17945]: go-librespot daemon starting... Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="app state loaded" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=info msg="zeroconf server listening on port 34367" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="obtained new client token: AAAnpvhrtWknx+CAn9akQZp7uvFfoNr6Qw9OdN5nXhEUQMzKvTEIf4MeaOkqhkjFgyL3DEoxnr8ryHUrVVpUQS8l+SyJECDlKKbbXENBnU7WOr1tANiDBcEQ/SFmezOhw2S1up+2q985SUwBmJBCFUYyfOFEPt6ALky9hVlEz79qL2KSEgK81Go/YFDvzfZFRQJi7FGd0Z9fOSBzGcwi1GUvW7Z0rxPnLeupKDxyzeimmyI0LWqiVlg=" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="completed keyexchange" Nov 01 10:41:59 volumio go-librespot[17946]: time="2025-11-01T10:41:59Z" level=debug msg="completed challenge" Nov 01 10:42:00 volumio go-librespot[17946]: time="2025-11-01T10:42:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:01 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:01 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81. Nov 01 10:42:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:03 volumio go-librespot[17967]: go-librespot daemon starting... Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="app state loaded" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=info msg="zeroconf server listening on port 42701" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="obtained new client token: AABDWijsmOo91/NuE315Qvi4m4okXIT9PL78vRJQ8EVMA4zfaAvA5R56//vymJ08EKyJWlL2vD3ybilhRK4jHvjsnpHWaj9Sf6IWTw+/aZeO1K2V6KF6ZgEUc4w7FJ67p7LViIb61RrYHetFYdrh9yMHPA05JmnEfiClbqDhes8XYNvjztuWAM6oqK/dRCkD0nxd2i1xuo/AS8fQ/RxkL7GuV7LzRAwnCW4AH9B2RenLeTj9fDGsJXI=" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="completed keyexchange" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=debug msg="completed challenge" Nov 01 10:42:03 volumio go-librespot[17968]: time="2025-11-01T10:42:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:04 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:04 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Nov 01 10:42:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:06 volumio go-librespot[17976]: go-librespot daemon starting... Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="app state loaded" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=info msg="zeroconf server listening on port 33943" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="obtained new client token: AACuVCC2qnnAuffWPJ+9nPVzBQ/tMfvMZpmrMzWPcUblECvHJmutJOmckHpOYQBaeZkCMb7WKlvS59lFdo9kkWaQu0UCV/xIpiCSO7rNi3OKLeorb64GeYNSssagWY6ks9u0WtjtgPHnkm4k3HtIq7U2b3BET+PYaDRqWm5JPfPW2PhVLcTQ0UGlxBZrFWOxnX/knm82/SXln9nrcIh3eHGmXE4a7laxSPFKwR6lXzq8NGtQOQBWitw=" Nov 01 10:42:06 volumio go-librespot[17977]: time="2025-11-01T10:42:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:07 volumio go-librespot[17977]: time="2025-11-01T10:42:07Z" level=debug msg="completed keyexchange" Nov 01 10:42:07 volumio go-librespot[17977]: time="2025-11-01T10:42:07Z" level=debug msg="completed challenge" Nov 01 10:42:07 volumio go-librespot[17977]: time="2025-11-01T10:42:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:07 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:07 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Nov 01 10:42:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:10 volumio go-librespot[17987]: go-librespot daemon starting... Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="app state loaded" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=info msg="zeroconf server listening on port 40327" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="obtained new client token: AADh8LBtNtpmVkFKAYQlRaUENDLqkzRRiUHjbVrybaGPYqOfeDsN1Bda532Omt7dBHWsDV/wKFlH7hGLvIGsuWXNf1qtoHmDbOFFvOwPRv02PxYDgAJAovC/Id9lb03dDx1k5HUCHvdr6b+dr2r2NAJoe1axxqduVPMoul9jrZ870LADRcjEuK+9mIQrmRtspBvlB49AOCnEbI1SvG9j64iJPNW9U6v4PMrw/Ya2UovHGRhjwrcAcBA=" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="completed keyexchange" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=debug msg="completed challenge" Nov 01 10:42:10 volumio go-librespot[17988]: time="2025-11-01T10:42:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:10 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:10 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:13 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:13 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Nov 01 10:42:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:13 volumio go-librespot[18009]: go-librespot daemon starting... Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="app state loaded" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=info msg="zeroconf server listening on port 43447" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="obtained new client token: AACayl8qnwqEfhNIvBMo9HpXzj7DAX5Xhnba5wdqRA0MyauSZYzd7uDgANt8QFkd12u2h8KNwTv9X8uEPhk/t7/fjLWX4xrrY4ksiecQCjEMkMv+9XMrPPrQm/GH/RtLPBGHGdgrLEeu2s8yBN7jlioKmAkK+NPxEkGeci6AI0+4Fi71J90Iggq1rp0uYAflm0vuO0ajNI8M0G/A0AFCEDNz8JaOJ2UxF2EmvhxnuGNXSNbrpl8m5+I=" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="completed keyexchange" Nov 01 10:42:13 volumio go-librespot[18010]: time="2025-11-01T10:42:13Z" level=debug msg="completed challenge" Nov 01 10:42:14 volumio go-librespot[18010]: time="2025-11-01T10:42:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:16 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:16 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Nov 01 10:42:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:17 volumio go-librespot[18017]: go-librespot daemon starting... Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="app state loaded" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=info msg="zeroconf server listening on port 44631" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="obtained new client token: AAAm3EQv3pKQOjsoPOz4WcAEi9+J12Epjr/c8g5FeN3F59ROSHiKmEDOFl6fV6D5g8DNopduz0PH+2gxZaYEJzZnwsIfMt7xGtVlpEgn1UjCEstEBs1VAF7+nRZw1PBtlXVZBe4YSZBjNwgnbYAqnvjwpVI/f239o1u2ycqpyfG0wldEE6pfhUF+ab5z51hv8lqMBAlU9g8kXuJeH1W+oaBFp5+VByisMFFQOv3woNvRoF26Fuwcat0=" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="completed keyexchange" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=debug msg="completed challenge" Nov 01 10:42:17 volumio go-librespot[18018]: time="2025-11-01T10:42:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:19 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:19 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Nov 01 10:42:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:20 volumio go-librespot[18025]: go-librespot daemon starting... Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="app state loaded" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=info msg="zeroconf server listening on port 33597" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="obtained new client token: AADb5skCkaMiBXCC/AEOr5dPBczZDvolCW5iVya5Y63sfPMHh8Q+G31l16TRd1LqwjPXqPaHuFQjhPh4WuEDB+ocaATY70seDBF06O820KQJUf+76lyFt5xZtGRGNuJHLNQbzNQi6aEP0MZAIKXj+rJUH3dJxDPBmN/gagJdBajxEo8SJ8+IcXaNLkB5b1tAXvUWq8i93YtnF2iUJYyXXzk6Lj7G2AxOgcO+FTGl7MLvXsc6+3ptOd4=" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="completed keyexchange" Nov 01 10:42:20 volumio go-librespot[18026]: time="2025-11-01T10:42:20Z" level=debug msg="completed challenge" Nov 01 10:42:21 volumio go-librespot[18026]: time="2025-11-01T10:42:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:22 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:22 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Nov 01 10:42:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:24 volumio go-librespot[18047]: go-librespot daemon starting... Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="app state loaded" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=info msg="zeroconf server listening on port 33163" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="obtained new client token: AAD0SVDJl++8BFtgSUaKo57+/oCTmQSqWtuXZ9lkGKnB2r5e6OwqLUO5tVSH9z2vnxlqFOfUR6wPMZTx0wVUPwaxrAZTCFEK0RhjMM7u8WI2doBXFRSmVQT1n5bNP1yT0VKsN+o/GVCJX7pTWieCBeqXWJT7henxa+kU9Vlj8v/o+yTlAhzwt5EI+PtYRKcckGcb8p2ByDFo9s7kprFq9vMoqCWvM58iEX6dAF9qD0GheyJ/l1btUpQ=" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="completed keyexchange" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=debug msg="completed challenge" Nov 01 10:42:24 volumio go-librespot[18048]: time="2025-11-01T10:42:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:25 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:25 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Nov 01 10:42:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:27 volumio go-librespot[18056]: go-librespot daemon starting... Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="app state loaded" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=info msg="zeroconf server listening on port 35983" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="obtained new client token: AAAHMD0+GIC1wuAfa1QDH3dfQRYtnoYcS4V5Vckj+YafxH9AqS08/svvqWs8lOo9UgwVyPUp0hkHeRJCS9UqX989dpIrpm5be7ZIGYCvSazUwbX1GvQVzv4L6TLyXBApYplvmIkAZicKvVYg3Tg110Sh0MGULJmzI4xiHvgbeTcm5vgWnlFgKS1znl+u65VN6wFvlZqshENILPnZrRJ+eA9JkryQovFMjLXG1plC53VPkIBeMADceyo=" Nov 01 10:42:27 volumio go-librespot[18057]: time="2025-11-01T10:42:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:28 volumio go-librespot[18057]: time="2025-11-01T10:42:28Z" level=debug msg="completed keyexchange" Nov 01 10:42:28 volumio go-librespot[18057]: time="2025-11-01T10:42:28Z" level=debug msg="completed challenge" Nov 01 10:42:28 volumio go-librespot[18057]: time="2025-11-01T10:42:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:28 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:28 volumio volumio[17253]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Nov 01 10:42:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 10:42:31 volumio go-librespot[18067]: go-librespot daemon starting... Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=info msg="running go-librespot 0.4.0" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="app state loaded" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=info msg="zeroconf server listening on port 46539" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="obtained new client token: AABBQwksSHChbBEeMzOx84sfH2Ki6Foav0/4F4EcKzLad7oVI5nFc8Sj8//PHzsZcjq7hx6l/lrU7wYb4A7yeZrw/dH+84p5RHFTGG4Waups67VgaDo+Amyg6/viIWUdFd1QWX1ZzdUUgFY9W0AdfTMczAg8Bz18mqK4Idrzmm+qdZI4JTs9GfNQ8Py4ZgJVvZ+OPKVdpIuHnq7ero3IhNzxyrcKBYVjxtR175oT44SQLlcEGntbfeo=" Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 10:42:31 volumio volumio[17253]: info: Initializing connection to go-librespot Websocket Nov 01 10:42:31 volumio go-librespot[18068]: time="2025-11-01T10:42:31Z" level=debug msg="new websocket client" Nov 01 10:42:31 volumio volumio[17253]: info: Connection to go-librespot Websocket established Nov 01 10:42:32 volumio go-librespot[18068]: time="2025-11-01T10:42:32Z" level=debug msg="completed keyexchange" Nov 01 10:42:32 volumio go-librespot[18068]: time="2025-11-01T10:42:32Z" level=debug msg="completed challenge" Nov 01 10:42:32 volumio go-librespot[18068]: time="2025-11-01T10:42:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 10:42:32 volumio volumio[17253]: info: Connection to go-librespot Websocket closed Nov 01 10:42:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 10:42:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 10:42:34 volumio volumio[17253]: info: Getting Spotify volume Nov 01 10:42:34 volumio volumio[17253]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:42:34 volumio volumio[17253]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 10:42:34 volumio volumio[17253]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 01 10:42:34 volumio volumio[17253]: errno: -111, Nov 01 10:42:34 volumio volumio[17253]: code: 'ECONNREFUSED', Nov 01 10:42:34 volumio volumio[17253]: syscall: 'connect', Nov 01 10:42:34 volumio volumio[17253]: address: '127.0.0.1', Nov 01 10:42:34 volumio volumio[17253]: port: 9879, Nov 01 10:42:34 volumio volumio[17253]: response: undefined Nov 01 10:42:34 volumio volumio[17253]: } Nov 01 10:42:34 volumio volumio[17253]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:42:34 volumio sudo[18103]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 10:41' Nov 01 10:42:34 volumio sudo[18103]: 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"