Oct 29 06:18:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Oct 29 06:18:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:01 volumio go-librespot[20996]: go-librespot daemon starting... Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="app state loaded" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=info msg="zeroconf server listening on port 42545" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="obtained new client token: AAAprEZmMyiMobZP/3t5En81NolSNhuo7M1rANs07B35yn+r0OKyb9CUKSKZTK7NgZzqbG21NLA3fjHGkAv/6zF8m7M3Ato5qrLKJSqNOSxUYQ9BK+vrAfdcPmUOQgDhLHrdEvX4fhG1MDclr1KrXNT9GnDliEhrv5Kn/HibhJ/0xpEco3EU+3dNO2E58fuR+W1Rjx4TI57AkpZqvFnEGa5r9m0HW3rz1SrD4M7/BhbeRKsT8TUzKXU=" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="completed keyexchange" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=debug msg="completed challenge" Oct 29 06:18:01 volumio go-librespot[20997]: time="2025-10-29T06:18:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:02 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:02 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:05 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:05 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Oct 29 06:18:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:05 volumio go-librespot[21007]: go-librespot daemon starting... Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="app state loaded" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=info msg="zeroconf server listening on port 41701" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="obtained new client token: AADNfDiKxd1JEO2jeduKT2+LdchQnDzjel3hABPeDZ8WEBrtUVPg3s6t+eWCfS6hwJSe+IZ3A7zYYwonEO90f5hYcMsrE18d2dGMaBrhF9O09ZUM3VZ0oY3yDj/xRLC5ltCUJsOl0x7R4Ym58KhPl7lHotayCfKm8MZeFz0sqEZ6S1Uv2KcsRBPRQsl3zlypCiCiLtIyKDryZ8PkVDK9/SG3Z/+x8Bmo/tZSsHL3R3xLtgyln6zI" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="completed keyexchange" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=debug msg="completed challenge" Oct 29 06:18:05 volumio go-librespot[21008]: time="2025-10-29T06:18:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:05 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:18:08 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:08 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Oct 29 06:18:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:08 volumio go-librespot[21030]: go-librespot daemon starting... Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="app state loaded" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=info msg="zeroconf server listening on port 35727" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="obtained new client token: AABf6vEmFYwwYLV/gq+0ZZioald6JJIIdaKK3T2mJ+WSo4VcY5luL8kNiqlgmjIk8I+xEHv4jdDLP8b+ee3pY3nAPOhMI32cRc9khntRi/GKF6gKg/U1P/y34tputMzRGsu5S9qd0JJOVBBrA4I/uroivcvJlcEk+eru6hiFCFzVVgCFwR1cJdOww3kHXhYRWyp5Y49RWBz4w4MJtmLx7SlkY1FIWHPODz4+GQVH7PXHa/4swgjvpAc=" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="completed keyexchange" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=debug msg="completed challenge" Oct 29 06:18:08 volumio go-librespot[21031]: time="2025-10-29T06:18:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:11 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:11 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Oct 29 06:18:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:12 volumio go-librespot[21038]: go-librespot daemon starting... Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="app state loaded" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=info msg="zeroconf server listening on port 36157" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="obtained new client token: AABxoUHaGFHipenV6Eg40K3dmblcyRUc28nTO5ArZpHU5gT5JDt3Onoi4h84PlqZYJDlH3dY7+o88SsjOiQFz0yxSJGsv3CzEsMc8PpYEZ25U05IL2scaI5VffOKfVrvt39hWOltyfkHJr3bAQE3d/zOsYd/yBTZQKG6QWBbrxJLnyYZB0A7U7xYA1MPfogu+g0WqtSSngqMjKa2vcw2OVOh/7rKrXdPm2BItgkA9eH9ZC1iPaFO" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="completed keyexchange" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=debug msg="completed challenge" Oct 29 06:18:12 volumio go-librespot[21039]: time="2025-10-29T06:18:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:14 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:14 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Oct 29 06:18:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:15 volumio go-librespot[21048]: go-librespot daemon starting... Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=debug msg="app state loaded" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18: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]" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18: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]" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18: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]" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=info msg="zeroconf server listening on port 44697" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=debug msg="obtained new client token: AACGu8VZneQbSL4vyrdX++IDqyZ/8piMpKM3SMVYmCyZdTzDPblvhNOWbygx3jvvLdFe3q1LZbhzQpoPjzGd4FdlMA4JaZV7yY4sT2Eh1xShmMSBkd9Jphv/J7Z9qdGKzOMGP4ZEhhGDC/ol8nb1Er5K+CrQEphKMzCThkc0ZXapZZs9hco3WBTW41pbpORZgYTb8E8FE7FrYJGkM+a9knM+kzNzppW7mDwNLGDheeq0H0CtViDPvoM=" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=debug msg="completed keyexchange" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=debug msg="completed challenge" Oct 29 06:18:15 volumio go-librespot[21049]: time="2025-10-29T06:18:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:17 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:17 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Oct 29 06:18:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:19 volumio go-librespot[21070]: go-librespot daemon starting... Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="app state loaded" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=info msg="zeroconf server listening on port 41147" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="obtained new client token: AACtrfeuV4CNwKITg2+oIZegTzoRP/84UXaS+Ghg5N8fRBoFpbo1tLnO//ip116M2ihIrwo+025+5Xr5dtSv4YaAehBsP5fE1Ec8I60ucbLfljtJNse8r0alsJJ7hX9QGQH/1f8XFRGRMCceRCDjuxzUYvfySaebtk9ctFWO14rkZT2cpxjWG+3QgtlxJbrbOIlk/pnMOFnfFnkzrYwzqCw6j6Wx6sWUeS2ba1ZoRdZvP7ftLLN9" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="completed keyexchange" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=debug msg="completed challenge" Oct 29 06:18:19 volumio go-librespot[21071]: time="2025-10-29T06:18:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:20 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:20 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:20 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:18:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Oct 29 06:18:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:22 volumio go-librespot[21081]: go-librespot daemon starting... Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="app state loaded" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=info msg="zeroconf server listening on port 41895" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="obtained new client token: AAA7iCJ1QwJeNFxmXzORyU8SQH89+jdI0/8QnGBrpvx1VrC0lFGFm9zVQPBYGKMDTx0UPg8iCO5zPJpsArogcj3imVoX/JuQe/5ONYtv+3kULdLPWy4kqzImoR9GnYiBxem7y+S8pC68i4VWXie3kNoBFX2N9RPNh1sMWLysrZyNdbWkRFNLSM3NnUuAVyrWKZ6IHBoerw1hgOT2f3t9sQilrwefayp9vAlXkB5WLwcE9BdxJtSU9Os=" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="completed keyexchange" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=debug msg="completed challenge" Oct 29 06:18:22 volumio go-librespot[21082]: time="2025-10-29T06:18:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:23 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:23 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Oct 29 06:18:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:26 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:26 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:26 volumio go-librespot[21089]: go-librespot daemon starting... Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="app state loaded" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=info msg="zeroconf server listening on port 44435" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="obtained new client token: AACC7/fLM71dlvVPk/P8/P3VRbwkNp8zH2FLnPl5caH91tUTREDucbgwclA2fPYER1XObCMqrKuVflrFBThsp4MIDvNhhMVw/ZtLwnmmUnrSLuQx7tNF/Dk+EgqFe17mI7OLqiFqb/5bM/ZhEUQt1U1q/ttxBhwbDYxJIZZ1GA1vO9AQsKLmD3AFi/IE5wwa/jXfFZHGLVuj9iAzJQ1jcHO9UxLTjR8ifgIAmKYrmLr9De3Uv/uO" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="completed keyexchange" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=debug msg="completed challenge" Oct 29 06:18:26 volumio go-librespot[21090]: time="2025-10-29T06:18:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:29 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:29 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76. Oct 29 06:18:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:29 volumio go-librespot[21111]: go-librespot daemon starting... Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="app state loaded" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=info msg="zeroconf server listening on port 45945" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="obtained new client token: AADisnpS0PZWgp38V+q1lLTbbDFnB4mnmFEhQWDUAUaypqJ//XWO2eWK/Xym5Tt4Jkneopr1Wj2JV669FSCVviewRugEDmofmX6UoX31/olm6NPAP6xuWbe+MO7zFRwo/Aq/3NwTxvsosq1Mn2PN4fSkHAf+YBfqzJiVLeYI241//5h5V2tfxegbcU6yEjkDBIdHDEtvzFqi4oaWx1PsKxT6paeoDyz8qk/N2xdQN6odSDHpNOVgefM=" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="completed keyexchange" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=debug msg="completed challenge" Oct 29 06:18:29 volumio go-librespot[21112]: time="2025-10-29T06:18:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:32 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:32 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Oct 29 06:18:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:33 volumio go-librespot[21119]: go-librespot daemon starting... Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="app state loaded" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=info msg="zeroconf server listening on port 39875" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="obtained new client token: AACJUAA4oQxlI5Eim2rtFKIjn7EUpI0+yL2dwQfVVwiPPER3BxiepWN/hNxw49W6ksiviuEsxCvLFeYJVQQBer7yVUQz4vKvJcUIyJn5od0s96oBlzBKvGvD+CK8AG3e8ssjdtKKEcrKfk5IptfI4B803e/RgU9cXbSz7Z6+viT4I8C+3ZNnbYxHI9mG6Yuz1VPsK3EcmBwnI0PnZgiqLmy/MD4JhvO7lkmA+IoHhQNapMlAxXeB" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="completed keyexchange" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=debug msg="completed challenge" Oct 29 06:18:33 volumio go-librespot[21120]: time="2025-10-29T06:18:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:35 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:35 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:35 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:18:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78. Oct 29 06:18:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:36 volumio go-librespot[21143]: go-librespot daemon starting... Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="app state loaded" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=info msg="zeroconf server listening on port 33567" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="obtained new client token: AACNZY7Ig4UEY3ddHBpBZoG1hKo5dJah3uueyRCpduJT17IXQWWEs6QK8OeO4Q81YMApteOq0yggAJTyZECeoUr4+J8/3eUr3xIVBXBliFqZwhPqulc4hwvOZ0iCGLg4aqyMnXQYP+zNYIKiRQgzwyevVM5HXbYbWHyLhIqsUxJiqGuShIRmWmmucFUYUbUfb3PG91byyI85DvRf7EDVdA+YZR8JHKmQ/0o83K+7XIjxsZCzlSEhQY8=" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="completed keyexchange" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=debug msg="completed challenge" Oct 29 06:18:36 volumio go-librespot[21144]: time="2025-10-29T06:18:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:38 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:38 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79. Oct 29 06:18:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:40 volumio go-librespot[21151]: go-librespot daemon starting... Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="app state loaded" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=info msg="zeroconf server listening on port 35977" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="obtained new client token: AACRKQOi6HBqzJXNpzQMk16KAJhnHAVgxYLXZ+eIu/TnlexX/VyBILhIcnJSHZOjygSZNbzuHCOSYzPcXPok3qK49DrSu0KzaFAG6PWeP0PlwHENbreizz4Cl6exxootTpIwRcTVixrYjnkFWSk0cEuyBMu6yu07NxTFruEv5SN+7X8j2JOyVB4baZzKdEngc1TSLF2gPavDM9k+RYQH2nectTpgc8QNXMw/+W4Xfm8J5KTbpUNY" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="completed keyexchange" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=debug msg="completed challenge" Oct 29 06:18:40 volumio go-librespot[21152]: time="2025-10-29T06:18:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:41 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:41 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80. Oct 29 06:18:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:43 volumio go-librespot[21163]: go-librespot daemon starting... Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="app state loaded" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=info msg="zeroconf server listening on port 37607" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="obtained new client token: AAAIAg94h7OcYMGJgJVrN12ADOCma7UGOaKAW2xs0zyOPcqE1Dixr5vaxQtVg3RLzRQ7jcxSRMYoEhVXYKa3ku2FXTFW4SZMV05OzWLCljt3qookJ0/xHFhyDQ9ETSE4wcNhYvLUipc0HpWaf16WW21UU5JSUNaGR8MoaDv9kihOCy5KhmfXQJ2PwoHeTDgTMewYDwV5LcnBqA4xZqSz62UVQU2geejRds7Ih83xQiF4wsUb7Y3w4Is=" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="completed keyexchange" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=debug msg="completed challenge" Oct 29 06:18:43 volumio go-librespot[21164]: time="2025-10-29T06:18:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:44 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:44 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81. Oct 29 06:18:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:47 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:47 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:47 volumio go-librespot[21185]: go-librespot daemon starting... Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="app state loaded" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=info msg="zeroconf server listening on port 45307" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="obtained new client token: AABowgxIRif4tQDZ7pK887dPBc5bJXunzsktY2Z5cgUHCh2ERGEKI9cVdoDM9opezI9svx03opORdEhPNgUgF5jcTNjGK5cJxNEsZEHOKj9Z6k9rg4/k2+/U4smlfNmUGrqRPI2v5Z0ixMQ3eH34CjEwe+OI+Hxk39ay4QDHVBEk905G6mWagIcpdfXFS789zVuwcPBGCVfmifvaENa3AdsSMN3DRRJHJ+DIvFUr7WTJdo4zuiad" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="completed keyexchange" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=debug msg="completed challenge" Oct 29 06:18:47 volumio go-librespot[21186]: time="2025-10-29T06:18:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:48 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:18:50 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:50 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Oct 29 06:18:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:50 volumio go-librespot[21193]: go-librespot daemon starting... Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="app state loaded" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=info msg="zeroconf server listening on port 44697" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="obtained new client token: AAAUPNSSt6Hoim9o+Xyc3o9VDqkvunuy8nJuyoFJW2d9Bmmr4UAGAZPjHxvGbwnCnKWfxaNuTbhWLtCcU5x3c71p+t7hSo+kQ7Z4B6z/7MMB1V5YijlhknQ7yDQ2pTTyydsEFbj8E/c/1XpjC1LQMbqXyQEvx9GP6Zu1EDcVzJjdq4RdGM9GBzOi8mew4XG0vnRWLVNHrxRhNI1oQOnvTq/bGyNR2imQbuv3dOPeTAxBrv+w2nNIK+A=" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="completed keyexchange" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=debug msg="completed challenge" Oct 29 06:18:50 volumio go-librespot[21194]: time="2025-10-29T06:18:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:53 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:53 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Oct 29 06:18:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:54 volumio go-librespot[21203]: go-librespot daemon starting... Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="app state loaded" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=info msg="zeroconf server listening on port 43421" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="obtained new client token: AAB9/GU8c9upMLQzqq8jkXurBCZkvt+ki53Y4rs3T55UQlhNOlMAFUFv8zWN5m77AGN9Xoza6qDetzsAedtEdhQrZP3CaW5nJlQRpk1oNbiLzuRxdwTy7xYKNehNscuPGoUF+SBsJTTyiihUHTq6RxQKRtQdiNujLmgYmXj1bipP36yXzTgf7OE4aOI/h5HcIcM0M2s44hkCC9eRG27gCjRNnAJHskk/PeW5F8GC8kIqdrGuSRgg" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="completed keyexchange" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=debug msg="completed challenge" Oct 29 06:18:54 volumio go-librespot[21204]: time="2025-10-29T06:18:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:56 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:56 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:18:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Oct 29 06:18:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:18:57 volumio go-librespot[21225]: go-librespot daemon starting... Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="app state loaded" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=info msg="zeroconf server listening on port 40009" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="obtained new client token: AACSBVvBT/HmBZXHyCOz+sE5o36Q7+vYgA7J4AYHmFJFacOcPteItJ5fYxR8NFLGBw2nIb1hH3f4mQnoGHxHgBiEDpPDJEgYab6Bg8ftrjs7GjFtQBppBgOQCe1iqzzgjLMp2Et7F/o8qg70++n65imidVa7kj9W9qJ5FYGlyiNCHMJS1HqNiLGAcHtG9X8TgXzjNhpVSJjfly9WmwOWktTfVMYPGMih9SYlpaqfGW8ds2ZASX5G5Lo=" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="completed keyexchange" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=debug msg="completed challenge" Oct 29 06:18:57 volumio go-librespot[21226]: time="2025-10-29T06:18:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:18:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:18:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:18:57 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:18:59 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:18:59 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Oct 29 06:19:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:01 volumio go-librespot[21233]: go-librespot daemon starting... Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="app state loaded" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=info msg="zeroconf server listening on port 41563" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="obtained new client token: AACHyQffFuQmScLAFUuCbf3inh9jGIrzTMi3K2ee7WbmqVhmIXOaMiv4a5qi59tqVmz6/CFdNTNtXJRNbfwrml8Pop16PReOkifp9a6l4DcJ8MmSbaIezDsqMKkG9RPz0Rgw8JU1lRC4FsYgEfiwrOrzImmnPaJmLvngLXLwlSa2lwmq0SiYc325I8SdrzzR13RmFCa7Ziu43O5nMcK2srf33T3RDkf1WJLuCiX7Hcb2ck02YgK9" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="completed keyexchange" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=debug msg="completed challenge" Oct 29 06:19:01 volumio go-librespot[21234]: time="2025-10-29T06:19:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:02 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:02 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Oct 29 06:19:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:04 volumio go-librespot[21244]: go-librespot daemon starting... Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="app state loaded" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=info msg="zeroconf server listening on port 45785" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="obtained new client token: AABHZGKLo/ZT0IBKAA7XR8E5gzx5AVzbDTf9cOH82PCe2k0z7O1yuqDxTJ1Hp45IwO5NHdagVJ/9iboi9B+tEq9v/FursIWlmzdiSD2CyWZeeQb0tGm1i0MyFOklgaWrCxdeE1qMa3Uxe/qZXB9n9bKgNzEI5s2NJDbaEDHQCZ6HoN5FkgQT7DsC/b3pYfcFCZ8+nRqrKO783y77C/J8Lp+3lpCkJ2TAUQWvTI3/Lb2AHaof7KqXlCU=" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="completed keyexchange" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=debug msg="completed challenge" Oct 29 06:19:04 volumio go-librespot[21245]: time="2025-10-29T06:19:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:05 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:05 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Oct 29 06:19:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:08 volumio go-librespot[21266]: go-librespot daemon starting... Oct 29 06:19:08 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:08 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="app state loaded" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=info msg="zeroconf server listening on port 37315" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="obtained new client token: AAAGXc068lOC4bWkkfCDIHcO1oF9XoqzjgIkXBmz6AA4cSY9+43tpJxSrRT58n8C0TNbASOnGKYaJF8jyVdPjp+z5wnNV01Iup7YEfLL0hrBJoPZve0QuAJG8MVc4qxnup+XkfpvJX2P4qDJL3yUFnqXRGaBmsb0AEuEauxtMxwPEYfYev4JmSIpl8WXmBdojT7acrmsbqZ6MlylTMHyF6E0KnNbVPyGnwx10QHkFFmrBWkyhm8t" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="completed keyexchange" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=debug msg="completed challenge" Oct 29 06:19:08 volumio go-librespot[21267]: time="2025-10-29T06:19:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:11 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:11 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Oct 29 06:19:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:11 volumio go-librespot[21274]: go-librespot daemon starting... Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="app state loaded" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=info msg="zeroconf server listening on port 42431" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="obtained new client token: AADG21m7S144ktHTjKOcFr2nYU18mxiEC/7N17xYgoSgQ70eigQDrmiqypTEqZG/eMi0pHv+C8Ft+pTauYGJcFixRkU9pFkRQiFNbAEfmsCIagrhNrvT/uuDcMr32Z0NUgT1OTATD7aPGCmYsLHRMwFrtMzQtPNVY7uYFcQ/AFUwZ36DhhJAsCErpfrQpgw790jSckmfsRVhywVen9ujqeTYQ9xM4nAL4MZWfjOV2Gh8B0dF/Omt6RI=" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="completed keyexchange" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=debug msg="completed challenge" Oct 29 06:19:11 volumio go-librespot[21275]: time="2025-10-29T06:19:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:14 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:14 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Oct 29 06:19:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:15 volumio go-librespot[21283]: go-librespot daemon starting... Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="app state loaded" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=info msg="zeroconf server listening on port 35593" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="obtained new client token: AADi20OZ3X84OeC4HqvnJxBieKmfoVVxo8bDJoCsiOJEBIVtUlZNLwl4F2rX9+24pbOJ10VxXwtFTDB77Bc1n5Zlw+Yzpa05JtCtsk8iWnNPOOIaNtj0x1kp/NcTe8JyIYhtG4s5rbcD5tkwbbUhJDhW6rBo43nJ0rJv+pZs40WzRUtqsS8xRLeboLAmakBVZ+0XNSc0bP4mzFyAWEgGWRSIDAAyKjkrxG7t96dsexDR6facSo60" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="completed keyexchange" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=debug msg="completed challenge" Oct 29 06:19:15 volumio go-librespot[21284]: time="2025-10-29T06:19:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:17 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:17 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90. Oct 29 06:19:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:18 volumio go-librespot[21305]: go-librespot daemon starting... Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="app state loaded" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=info msg="zeroconf server listening on port 37441" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="obtained new client token: AAANcOtR9vVoscFsmcItH8PnOkCXkUl/kozSFFyLBrKU5HJGtCs6vUdwUJ7MvNkoSTPy4swKn0Rfiyh6JaAs0xR8saVk3OyYtm9oCyjnkKbzcZMk0ENEfKFynVzCzMR/eS7hsKx+gVWvuij9TrSu+EHDlGNnWM7tVlfmup0ADv7Y6URSzhMPppi2gzKDwKaD3YvRv0K1EpdIic5F7N3lokiVbaMAJffnbfz0fO54W63l3sNppxvsh78=" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="completed keyexchange" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=debug msg="completed challenge" Oct 29 06:19:18 volumio go-librespot[21306]: time="2025-10-29T06:19:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:20 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:20 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91. Oct 29 06:19:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:22 volumio go-librespot[21316]: go-librespot daemon starting... Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="app state loaded" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=info msg="zeroconf server listening on port 33259" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="obtained new client token: AADcSHRyPzwG0hp/Z8vyWvu6Nn8rPlCw+tfsfmZUTcNdJoDmD/b8k1JglyujU1o6ngvOIVk9e6oB9c2Q4b4P0mY+E5ltW1Jax3yugtrB7cMf9H0FJ8vy4N8/bVJBQPKw9CEoQ7yA+mCuXVr9MnUqLs3CVn8tmLxPFUMbtIV1wlr3TqgmfSQn7/DPYmlyOU2OaWLgLuON+q/u4knxKrt+91zuc+bsP3yz21f5jDwM7IpzFGvJojs4" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="completed keyexchange" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=debug msg="completed challenge" Oct 29 06:19:22 volumio go-librespot[21317]: time="2025-10-29T06:19:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:23 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:23 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:23 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:19:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92. Oct 29 06:19:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:25 volumio go-librespot[21324]: go-librespot daemon starting... Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="app state loaded" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=info msg="zeroconf server listening on port 38417" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="obtained new client token: AACCLFVE8sX4rafWXWJ8BPz0cmSwfgUN9CbcnT4R0zXCXPBKC2Kg+Q2qheTVXiiYbmvNXW7epUHif73P0H4WHifNpx1f6zVp6kFqV6wJDYnkuHXg2j8FTG3zG1o5NfurXr2IgsAYQwtB3jUFHUAamO2wB7bKrQ2sBaEXAoj0CmHka4gpFdqCJnUSQVEW6M2r/Jv0/J25q3GsoqnLhrB3Q2sKx9oMqJO9ILnQU390T1FTPq/2Pz5J9go=" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="completed keyexchange" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=debug msg="completed challenge" Oct 29 06:19:25 volumio go-librespot[21325]: time="2025-10-29T06:19:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:26 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:26 volumio volumio[20441]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Oct 29 06:19:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 06:19:29 volumio go-librespot[21346]: go-librespot daemon starting... Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=info msg="running go-librespot 0.4.0" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="app state loaded" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 06:19:29 volumio volumio[20441]: info: Initializing connection to go-librespot Websocket Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="new websocket client" Oct 29 06:19:29 volumio volumio[20441]: info: Connection to go-librespot Websocket established Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=info msg="zeroconf server listening on port 45235" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="obtained new client token: AABb9tq9ioDSoZxpz8vD+bDhYSozeOcjm16U+evqwHinfU/dO/71GgojRJ+Cyy+Pbno1O7XHmpVlt23avZPQTuaNZXzsGY3aWeCpvC8rrL0IpvcoBV+IBsMpINsxRXWIQsE0zDwzikNO3K+cqdKa78gNpNkNlaJgjOmaz+xJlErgVwAGOJvcPPhO6karVuavmK1iUuu4UIprn2NengU9BC9PNjxp01uNiHjYTBqEAAafWjEYAdXC" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="completed keyexchange" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=debug msg="completed challenge" Oct 29 06:19:29 volumio go-librespot[21347]: time="2025-10-29T06:19:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 06:19:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 06:19:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 06:19:29 volumio volumio[20441]: info: Connection to go-librespot Websocket closed Oct 29 06:19:32 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 29 06:19:32 volumio volumio[20441]: info: Getting Spotify volume Oct 29 06:19:32 volumio volumio[20441]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 06:19:32 volumio volumio[20441]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 06:19:32 volumio volumio[20441]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 29 06:19:32 volumio volumio[20441]: errno: -111, Oct 29 06:19:32 volumio volumio[20441]: code: 'ECONNREFUSED', Oct 29 06:19:32 volumio volumio[20441]: syscall: 'connect', Oct 29 06:19:32 volumio volumio[20441]: address: '127.0.0.1', Oct 29 06:19:32 volumio volumio[20441]: port: 9879, Oct 29 06:19:32 volumio volumio[20441]: response: undefined Oct 29 06:19:32 volumio volumio[20441]: } Oct 29 06:19:32 volumio volumio[20441]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 06:19:32 volumio sudo[21368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-29 06:18' Oct 29 06:19:32 volumio sudo[21368]: 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"