Nov 01 06:45:00 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:45:01 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:01 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 333. Nov 01 06:45:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:02 volumio go-librespot[22497]: go-librespot daemon starting... Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="app state loaded" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" 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 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" 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 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=info msg="zeroconf server listening on port 41933" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="obtained new client token: AAD8zw1SgeNdJQsrr/KDXIO64OBk760XhgV38U8slLKq8fXcvZk3S12hR43h2ReqRcLs7Nn7AcG2aMe0+WSfY4MtfNz6OX3IUCGjCZhdX4yaYAmemw8RojwUNsgRLjAjxHMV2VpZQf6i6oEyt9K/D+rbQYEURc6waMgb3yDPMSEHyIjd+Nmy7TBAaeMZezZHJMxsyTVQaZjH/ABcqTH5zQKr5VEMaP0EeY7IfyujuAi7NMpXWpUPhYs=" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="completed keyexchange" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=debug msg="completed challenge" Nov 01 06:45:02 volumio go-librespot[22498]: time="2025-11-01T06:45:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:04 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:04 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 334. Nov 01 06:45:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:06 volumio go-librespot[22519]: go-librespot daemon starting... Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="app state loaded" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=info msg="zeroconf server listening on port 35639" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="obtained new client token: AAAAbVuXhUQf1tIJIBeAuejXLxsIx4VGwXvEluBcUqzpyJT9RJHndn20Mld0YqnTEbz6rFa3p1N1mEYfjC5VGbAqdlgX5+jlIpGx7Cm61E066QaY65qPFD1GBvVddUaUdtL9qNRQZ09x0S+PsrLBglUrESQRJ/8KK+/NHhEwqp2X4mAjTvLh40p9ZdOoMB2eLMlIygCZyUEvp5TRSJOZt31ZQZAZpLRwhvQChLII/hYz/4AXmQ1D" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="completed keyexchange" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=debug msg="completed challenge" Nov 01 06:45:06 volumio go-librespot[22520]: time="2025-11-01T06:45:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:07 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:07 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:07 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:45:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 335. Nov 01 06:45:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:09 volumio go-librespot[22527]: go-librespot daemon starting... Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="app state loaded" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=info msg="zeroconf server listening on port 43673" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="obtained new client token: AAA5SwYy1cfwMcX7N1sXttBj5m1ZHyWJzWmojTmhABUnx2kpvoebqjYclOOaT6f0JlhUoH3afu4YUwBtQbQjDEDvH8/2BBOY/gjzd/DNI38XjZ2/NQNt7agogjVWIsReQMh+1PaqFgpsSLEDc3hLPbFDDzffknpTYbtkoANtb4jpTOTYFcLTail+YS3Yj6C8RcfozMQ4C7lFhZuakY8ObQRpFPfeSVsNwwhSzuODHi84qOdjhdHrFrE=" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="completed keyexchange" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=debug msg="completed challenge" Nov 01 06:45:09 volumio go-librespot[22528]: time="2025-11-01T06:45:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:10 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:10 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 336. Nov 01 06:45:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:13 volumio go-librespot[22538]: go-librespot daemon starting... Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="app state loaded" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=info msg="zeroconf server listening on port 32991" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="obtained new client token: AAAAPeoF5UAyML+wa5qiaM4Lp0sAM9XcQ6SvSqCViG7bZL08a+/EX29mt8HoHwzi42Q4AgqXR6iTgVXphmd7aIFglfGvbqwCLZLybOQlAiErsXwq2A+rOPgFodrLgRHXITjkH2NzetU786Aw819UEMTyxZvtcqLWBaPKcFxQa+I7NOkfnkGL4b7oMqN8gUJGf0YbO1tkZ7AMfm5nu/EaAj5JxoIOch09a4ar/VQ6LRA2dlaVT5sB" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="completed keyexchange" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=debug msg="completed challenge" Nov 01 06:45:13 volumio go-librespot[22540]: time="2025-11-01T06:45:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:13 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:13 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:16 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:16 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 337. Nov 01 06:45:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:16 volumio go-librespot[22561]: go-librespot daemon starting... Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="app state loaded" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=info msg="zeroconf server listening on port 33219" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="obtained new client token: AAColqgny5JLLuJ8ZMsyyxS4ZCiOTb6VycULx3rrgLYwFvkHe9ZjXsTImL5JaZ9zasqCIQvRbaEErjrs2hKI1HbTwaavOqhQT3bkaqI91lAV4skOt19WzEDqioHW2rjiak/1Qfy+wt+729l3DlHWRg1KjdY9lBIRj86uXj3sr/x2pgQJSGa0jx9cdOqhsHBJZKkDjHW6U/etnobQeyheCpQzF+dKkqWnwOMWhXh3yABqZ6FKMi7118g=" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="completed keyexchange" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=debug msg="completed challenge" Nov 01 06:45:16 volumio go-librespot[22562]: time="2025-11-01T06:45:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:19 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:19 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 338. Nov 01 06:45:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:20 volumio go-librespot[22569]: go-librespot daemon starting... Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="app state loaded" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" 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 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" 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 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=info msg="zeroconf server listening on port 40351" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="obtained new client token: AABIhT3bJckThhaKorq6KBNjChVXHFjQpwjyPa9MarVg00QwEoXufLJ9NOE+kubZ4l5Z3yCiwBLTFG3xa7VOWA7ERkvNe3VbMiw/Hjj6buyxRy1673hszGvrX1FUTT4sMMfggy/suEQUGhurhZ+ach3MCHT5XDP2MWUg2spm5dL2rXcTvat0Rsmd3M04S1BMpBobVYAoitDKIsUN//0A4Fg96EccQC5J0UT0sB+ZeJWYI/D1pOAm" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="completed keyexchange" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=debug msg="completed challenge" Nov 01 06:45:20 volumio go-librespot[22570]: time="2025-11-01T06:45:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:21 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:45:22 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:22 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 339. Nov 01 06:45:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:23 volumio go-librespot[22577]: go-librespot daemon starting... Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=debug msg="app state loaded" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" 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 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" 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 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" 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 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=info msg="zeroconf server listening on port 41129" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=debug msg="obtained new client token: AAAclCoNV3gZcoQCUB2oVytphKxWljJGksnRJzIWVdQ/QPU1zWZPhoIYgSR/FHvNOPhpsM9MZ9Fof1Y1a8gRuyJKaf5P3VOwtq3Ca3spFDVehMQuVHnGmoyXIO8IkZA2bR8b/ySClSpVtP6LL2XWkGmQBw/rONMHNMn+rmvFjBOj1UOlAa1lBuTNj0S9cTwUMHAkpP30X7yXoq/6ovsAG7ohrDSIgv+9az+0138c+cI68IqrPoChj34=" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" 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 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=debug msg="completed keyexchange" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=debug msg="completed challenge" Nov 01 06:45:23 volumio go-librespot[22578]: time="2025-11-01T06:45:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:25 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:25 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 340. Nov 01 06:45:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:27 volumio go-librespot[22599]: go-librespot daemon starting... Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=debug msg="app state loaded" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45: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 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45: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 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45: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 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=info msg="zeroconf server listening on port 45929" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=debug msg="obtained new client token: AADV8PveTkYMPm45HROoiz0ee1EGCTQlEafuq/1kZnH9HZyRLGUUebi7BCpGZWRnoBs3RIOnYgni2IxBnORgzF3R3nRGMsp7pjc/hekl+qL1dCMmGAsyNuBm0EHhqHQ1OSALEKtiLWBMJVqx1MD0elA51UKPxfZy9sOHeodpuPHSQ4oEO/9KvhoPMVAk/4RYWaM2ueXJAaCgy73mOKr8P3FRjnn/KfOtEd4VsCiXvZa3/QyMxfVt" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=debug msg="completed keyexchange" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" level=debug msg="completed challenge" Nov 01 06:45:27 volumio go-librespot[22600]: time="2025-11-01T06:45:27Z" 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 06:45:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:28 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:28 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 341. Nov 01 06:45:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:30 volumio go-librespot[22607]: go-librespot daemon starting... Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="app state loaded" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=info msg="zeroconf server listening on port 38395" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="obtained new client token: AACxTKTB2gFDrj7oqh94e/bz3EHPoxLti/z7RcKvbtZlO0wyEAovtoaZLZoGqoBT5MT/zUozNrctN/5ru2nrTaiDaaPayDEOP4BVD5qpMzUgAvUSbLeQIaOu78E3fEcg5wzRelZnX+1+uwgNs2W7oXlugoWIVs/8+DxXHnLYSXWObmg/SiFy/wjoQa7gqBOYYxsEnlTxwpDca3zY7mNeuJ5edLtAvZnTcJ2XpYl7tDuMPzcPVheBc58=" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="completed keyexchange" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=debug msg="completed challenge" Nov 01 06:45:30 volumio go-librespot[22608]: time="2025-11-01T06:45:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:31 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:31 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 342. Nov 01 06:45:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:34 volumio go-librespot[22620]: go-librespot daemon starting... Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="app state loaded" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" 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 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" 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 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=info msg="zeroconf server listening on port 37147" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="obtained new client token: AAAl4rYNQStg1f4XdIbLnzZEmxmMi3UC/+shuwrq58zaWQUtDxywSqsvvtHQZxPFuW83q8FKqBOb1Q9Hd4J9EtDNXw2lCd930e2kOdHqx3FXsiVB/AuTum/7Tsz6IWK2FEFWR2JLqwgLUIjl0brshSrMhLMEUASR/lnyAxuKYejBN0NMtBfY6LtRd2PEagMP4Zy8qUganUbiEFT13zdibhyhwsOEStz1VU9UF8Vg8mVFuupjrmAn" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="completed keyexchange" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" level=debug msg="completed challenge" Nov 01 06:45:34 volumio go-librespot[22621]: time="2025-11-01T06:45:34Z" 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 06:45:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:34 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:34 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:35 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:45:37 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:37 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 343. Nov 01 06:45:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:37 volumio go-librespot[22644]: go-librespot daemon starting... Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=debug msg="app state loaded" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45: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]" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45: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]" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45: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]" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=info msg="zeroconf server listening on port 36919" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=debug msg="obtained new client token: AAA/q6mb1wJn35W6DnG8j4RuEgTwu/oFg3nBPrXjnAGx0lHO0HB6vbapPDk6HI0zWjQbVGivefPUZBevuyQZcCtZLiMjhCvTVGzERCrrP10lWPXt3KKGO0GKn+nr81cpMUY7F+cQgjYHatSHEoIOXM9g/M85b0dg/eSI+/o4+sBaJRWhQOZcQz2ZxDb6tfP5K1u0j/9i5iic72zBe7fFCJ1RX7mWFoga4iQX6KOjjxU4ZmaZfHjI+Gw=" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=debug msg="completed keyexchange" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=debug msg="completed challenge" Nov 01 06:45:37 volumio go-librespot[22645]: time="2025-11-01T06:45:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:40 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:40 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 344. Nov 01 06:45:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:41 volumio go-librespot[22653]: go-librespot daemon starting... Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=debug msg="app state loaded" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" 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 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" 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 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" 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 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=info msg="zeroconf server listening on port 36581" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=debug msg="obtained new client token: AAC/7ndz9TbLGA075vz118jHXuO1Wfd8Iv8/rU0h/oTTkRaxOzuWjY6PpMN/uWMHDRdgOrB0ucuF2jEwIf+ZubDwrKJ3tldEnTlCHkQXvDW4AjZpeg7oO1ja0zgsaoLPZh5zzYdvupBHWGAE4TONfbT7Pgw3kfmk4cc4UO7MaZvAfyaFji2HNGUd/VotaC6PNALOM861jp0n8BEj7NABHgPV77+dNMqyKlWhojoYifeCxOiyAuUd" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=debug msg="completed keyexchange" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" level=debug msg="completed challenge" Nov 01 06:45:41 volumio go-librespot[22654]: time="2025-11-01T06:45:41Z" 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 06:45:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:43 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:43 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 345. Nov 01 06:45:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:44 volumio go-librespot[22661]: go-librespot daemon starting... Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=debug msg="app state loaded" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45: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]" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45: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]" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45: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]" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=info msg="zeroconf server listening on port 34269" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=debug msg="obtained new client token: AACqfwL045mUThhbinIYgdSdYUuTE50o3HF2Z+auXZ6AKQlBAGDsSrM6hPfHmAp1plmUJB1bYiCDTcgoOVpBimm1zROtfV6D65p9MxltGTatgUfioRUPNWtNP6Qu+QjAowBOqKbjwAStGmDOAbE/JTR/Ri8SskNHwH8LrxOCnaHvSYICM/y9xf63V3bCw211V9r7YTu58dVfEN31a9RpGMGfdxlWLULxSWWVorcaAU4chgTh3kJ0oXI=" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=debug msg="completed keyexchange" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=debug msg="completed challenge" Nov 01 06:45:44 volumio go-librespot[22662]: time="2025-11-01T06:45:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:46 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:46 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 346. Nov 01 06:45:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:48 volumio go-librespot[22684]: go-librespot daemon starting... Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="app state loaded" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" 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 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" 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 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=info msg="zeroconf server listening on port 35205" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="obtained new client token: AACpGqHSTFzvnRg7Rl+N7+JUaw+l1NKI9mB6U3Ioz2wwtc/TCvLDI/197QYV1ZoOpiEfMnxrlQMAdg+LH6ylYWaMXKpEQuBWGs0qGDTWLoXKRS+C4ew8IUtMwhWvXUwpUCIqYrWQ0xtIVhRs5Tb2ihGdoQN2okt3dr7jNIRUMeL7EDo1lv0ZbIeJHZI/2EusY9nKmvgrzU6SITonIYhJcSzYgOfwgbbTLofzZq1p67hXbGYFUaNw" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="completed keyexchange" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" level=debug msg="completed challenge" Nov 01 06:45:48 volumio go-librespot[22685]: time="2025-11-01T06:45:48Z" 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 06:45:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:49 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:49 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 347. Nov 01 06:45:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:51 volumio go-librespot[22698]: go-librespot daemon starting... Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=debug msg="app state loaded" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45: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]" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45: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]" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45: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]" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=info msg="zeroconf server listening on port 44161" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=debug msg="obtained new client token: AAAVtgL6O8pwC6Ct4KP2fH2XRbjuYXD3ySFbMmEMNBxTVdoVd8BfyZVuYXXb5z4hP3mU/2JqR/4kaOCxuGkqaolXpeUXluuHqrdn6BkOM01X18p1AKjsRtjmptWfyD/526JJKBPbJGLcV87rLILTxyhF6EId4txw9g1QduW1md7Dp53sIK4zuF2hTfJJ++iL1fg3oOuXZe61LgmKfPE47kkrrf3trJaRbDBT/wU5yepdLqbxp/cJJSE=" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=debug msg="completed keyexchange" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=debug msg="completed challenge" Nov 01 06:45:51 volumio go-librespot[22699]: time="2025-11-01T06:45:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:51 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:45:52 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:52 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 348. Nov 01 06:45:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:55 volumio go-librespot[22706]: go-librespot daemon starting... Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=debug msg="app state loaded" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" 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 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" 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 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" 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 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=info msg="zeroconf server listening on port 45823" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=debug msg="obtained new client token: AADXzAAPCp+GH9r3iAxk8vq+E33jXFRjo62geUsRiaun1AUrg3EIoggCz8pUvLVDcjmsjYXSKL5qKNdCOdYqYT7ddIsf4uQhToz8bH9XKuNm8wb2+fKaO4mXkxRyJNHKILXOrFBz4OF36TBRj82gixfum0g70GWDYneAmKZHOFvDsbmdeRLFMbNN3MX3MNjm/mhqltbRqZ0Gn1F7hsG2bIsb6J+Dk7QESoOJu01N7X9nLCYllc0Y" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=debug msg="completed keyexchange" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" level=debug msg="completed challenge" Nov 01 06:45:55 volumio go-librespot[22707]: time="2025-11-01T06:45:55Z" 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 06:45:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:45:55 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:55 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:58 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:45:58 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 349. Nov 01 06:45:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:45:58 volumio go-librespot[22728]: go-librespot daemon starting... Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="app state loaded" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=info msg="zeroconf server listening on port 34641" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="obtained new client token: AADs0HRrd3YQgcw8d7Ouv+m7KkTWZ6P/clL66u23w8tYxfulGbKdh4dR1N7bJ2o1xgJtBliTJ1w3cnKJVxh+++JWGFV2QNnsfAhX7qmzMVBZivFHav5krCCEaSKVwWq6Uo3067CTa7x9XnLmzE/49+C0nDGX6M0Xs7q3mxxMLGf7JecUIwlPfEs73BLLI6agzs5xw4Z3v0sgDUvdjSdHK5dhEFk7EyqisaDDy395XX3hR7RN1sDR/1Q=" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="completed keyexchange" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=debug msg="completed challenge" Nov 01 06:45:58 volumio go-librespot[22729]: time="2025-11-01T06:45:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:45:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:01 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:01 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 350. Nov 01 06:46:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:02 volumio go-librespot[22737]: go-librespot daemon starting... Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=debug msg="app state loaded" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46: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]" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46: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]" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46: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]" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=info msg="zeroconf server listening on port 38095" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=debug msg="obtained new client token: AADek3Ks1m8JmrpdOzp381VhcCfX3R0Zh3Ozq3VNNq4P82hmFVdDBsgLdLhVR6pCMeXOhUjsZDyJcR726alvhDJi7V0/UIN/ihNTxzj6UuOuCyq7uM1x4rzUWfiPvHSc8AbQVFt/n0utlDyB3sI7CoVUEmUAg+CCPwvvtROPVO32BRWR8WddPB0W+pPfxfu7GoNwGG2R3y7UYY9qoRRy78CBVdZj5yxhrIl+JD3bBZoJc/IGmD1Z" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=debug msg="completed keyexchange" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=debug msg="completed challenge" Nov 01 06:46:02 volumio go-librespot[22738]: time="2025-11-01T06:46:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:04 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:04 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:05 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 01 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351. Nov 01 06:46:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:05 volumio go-librespot[22745]: go-librespot daemon starting... Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=debug msg="app state loaded" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" 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 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" 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 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" 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 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=info msg="zeroconf server listening on port 36757" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=debug msg="obtained new client token: AAAK81PJpTxV5di9JDksvVAIJjbED5oiDcgFR+KxSFJPFY9g+/3KwOxGLicCe9cjbZJh3aXqZfun31I4tgkv014bd9V1asl1A1JVEKQtQ1y7ffFgr0ufJ8Ku+9dv3aUNdWIybqAlyBUePZqBTD+7/N2tXuKcXdP6j4VIirPzSY5uwnOKR4GNROZvoLJZ6G7DmkBYOlA+QcWHKCMXBmz5bYMveFBrvr/97F6bpLMkgtEeaTmwXEi8JtU=" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" 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 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=debug msg="completed keyexchange" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=debug msg="completed challenge" Nov 01 06:46:05 volumio go-librespot[22746]: time="2025-11-01T06:46:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:07 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:07 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 352. Nov 01 06:46:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:09 volumio go-librespot[22767]: go-librespot daemon starting... Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="app state loaded" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=info msg="zeroconf server listening on port 42245" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="obtained new client token: AACzFi3x1TZjtOFJqalebjYo4VhiXA4SF/qY+t4MoQwK+2BDPQLgiADBnOP93zvuHfQUIm6733y53eMvGGMOSloJYBiqEZ3IADAkogiuRoHUXNhI9I+Ga60D0BCmEZfI83sDiS0A+YetL/3P1r16eynWINkVLaHtblJ1ELe6EiO7DnwD0S86dxL89DIQw0t9F/xDGYigIG/oYlEI7tAsSCtCZMExjdFmW2q8na7x+ibD4EBtJXUx" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" 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 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="completed keyexchange" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=debug msg="completed challenge" Nov 01 06:46:09 volumio go-librespot[22768]: time="2025-11-01T06:46:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:10 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:10 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 353. Nov 01 06:46:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:12 volumio go-librespot[22778]: go-librespot daemon starting... Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="app state loaded" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=info msg="zeroconf server listening on port 38801" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="obtained new client token: AAAdS1osNsvwFhZvKZZLFsGr1sLNrraBkPwuQNWLIN8wQ2vMY7OuEhxoVhG311ahgExjbo7YFq5JmHNki28iOspKEFr6LU0cYAtZRtjHv67zYzjMM3mihKFdxBipEVQw3srZQuqB6GoYOCApfpWL4SXC4+onoU2U3GXpc/QW/IjPBZ8Unrklt5O/6K4vkknvuzxuQWOcAumbkA4xukZtqLYIfIUzZTqq5nnrzVlEtxtmMIzYDRqNsAk=" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="completed keyexchange" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=debug msg="completed challenge" Nov 01 06:46:12 volumio go-librespot[22779]: time="2025-11-01T06:46:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:13 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:13 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 354. Nov 01 06:46:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:15 volumio go-librespot[22786]: go-librespot daemon starting... Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=debug msg="app state loaded" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" 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 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" 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 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=info msg="zeroconf server listening on port 46073" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=debug msg="obtained new client token: AABPVzzhbo7hmNLUW4OYI9As9hkxlhqdySikjnnRqi3hpmT6Z9Ir5a9I2tAkU7YF8GHJq9vhcVLBoGyVljQigd/h5uLtQiN1M/Cb9GgwvRfnSqyB9FP+eqypdclozwxl/S9GGKwBFKWbM1crDUEdu6Ezt2UQk4fI3QCYSJ7XeqD3etKVgaI6FE1rEX6HSPs+4A5+SIbJfsL+8lA7U9EMNNtFsonWc7AM+XNgKnVVvcHauHfvi05mFU8=" Nov 01 06:46:15 volumio go-librespot[22787]: time="2025-11-01T06:46:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:46:16 volumio go-librespot[22787]: time="2025-11-01T06:46:16Z" level=debug msg="completed keyexchange" Nov 01 06:46:16 volumio go-librespot[22787]: time="2025-11-01T06:46:16Z" level=debug msg="completed challenge" Nov 01 06:46:16 volumio go-librespot[22787]: time="2025-11-01T06:46:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:16 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:16 volumio volumio[21822]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 355. Nov 01 06:46:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 06:46:19 volumio go-librespot[22810]: go-librespot daemon starting... Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=info msg="running go-librespot 0.4.0" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="app state loaded" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=info msg="zeroconf server listening on port 34715" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="obtained new client token: AAByeWKSU7FdT5V4XAxdahoqY9yXYDQlaqwXowwhIWu9xoysl6YtjCY4G+6YSCyMjqSkylmUPdHIqOHra6m8rcjmYutgWSu5HUpn0spUjWsnX9QxREivyo00UxI6hhjEEIIbx8yHnJtobnq3siXCUHYniy5smekac2mxwh1UFC0ol7WPeXusUZySjEhtEK3EiTUDtCNw+MkI/xSLfPYsTRy/7HrZSleLNfkqyCVdNYLHbHxehi55aIo=" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 06:46:19 volumio volumio[21822]: info: Initializing connection to go-librespot Websocket Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="new websocket client" Nov 01 06:46:19 volumio volumio[21822]: info: Connection to go-librespot Websocket established Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="completed keyexchange" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=debug msg="completed challenge" Nov 01 06:46:19 volumio go-librespot[22811]: time="2025-11-01T06:46:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 06:46:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 06:46:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 06:46:19 volumio volumio[21822]: info: Connection to go-librespot Websocket closed Nov 01 06:46:22 volumio volumio[21822]: info: Getting Spotify volume Nov 01 06:46:22 volumio volumio[21822]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 06:46:22 volumio volumio[21822]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 06:46:22 volumio volumio[21822]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 01 06:46:22 volumio volumio[21822]: errno: -111, Nov 01 06:46:22 volumio volumio[21822]: code: 'ECONNREFUSED', Nov 01 06:46:22 volumio volumio[21822]: syscall: 'connect', Nov 01 06:46:22 volumio volumio[21822]: address: '127.0.0.1', Nov 01 06:46:22 volumio volumio[21822]: port: 9879, Nov 01 06:46:22 volumio volumio[21822]: response: undefined Nov 01 06:46:22 volumio volumio[21822]: } Nov 01 06:46:22 volumio volumio[21822]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 06:46:22 volumio sudo[22833]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 06:45' Nov 01 06:46:22 volumio sudo[22833]: 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"