Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" 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 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" 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 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" 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 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=info msg="zeroconf server listening on port 33821" Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=debug msg="obtained new client token: AADYxBT2qMyXWmc0o36VR/QSc+wese5DjBlr7Skd3tf7UvZxyShRwNJ8YbzTnKVKryPSEv+WJrGPN0emOUlX6EkFZrbABDwJzAeK/kTD1oI7bqPCzUL+B3bIXAUkd9SYOd0+lve0qGXia8Rg2IQIZayBnyxgs3sPdsTQ3kEXeXDZgvmm2RwX0cSmRORUmlXLOQBtJN7JzbD94THzB4oh3+WtDxOOTvKoe4E5lbHVwvhYtmdseUat" Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=debug msg="completed challenge" Oct 25 06:38:00 volumio go-librespot[27263]: time="2025-10-25T06:38:00+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:01 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:01 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 225. Oct 25 06:38:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:03 volumio go-librespot[27275]: go-librespot daemon starting... Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=debug msg="app state loaded" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" 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 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" 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 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" 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 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=info msg="zeroconf server listening on port 41713" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=debug msg="obtained new client token: AADOuaxydKXkdhmz9fPg1d9t8jjcsKnpWkbgbdh9EGtw1khqqbRnS80oxcLtNfoinnG4OuMY9/HD4M6sGaL+ovgQxvkDubHTBsEMvpzV3sKIkOv+yoptRxpaUA8+HofEUAjFtL7qV7CVf2mJLCQo0NXWu42F4OgYUXSlf/IN4iHuvO62CiNYnvCP12mYbZdh1rpu+lGU1O9TmuaNTHhkLggBwZq0VuXL5voAkn4NCEsvsVBK5u4cHmc=" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=debug msg="completed challenge" Oct 25 06:38:03 volumio go-librespot[27276]: time="2025-10-25T06:38:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:04 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:04 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 226. Oct 25 06:38:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:06 volumio go-librespot[27297]: go-librespot daemon starting... Oct 25 06:38:06 volumio go-librespot[27298]: time="2025-10-25T06:38:06+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:06 volumio go-librespot[27298]: time="2025-10-25T06:38:06+01:00" level=debug msg="app state loaded" Oct 25 06:38:06 volumio go-librespot[27298]: time="2025-10-25T06:38:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" 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 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" 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 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" 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 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=info msg="zeroconf server listening on port 32861" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=debug msg="obtained new client token: AAAzYcsWiD/n6rwg3IhyLblPujgGGDOaQDBmTs+ttcUDJbXE+NGnMvSiYMKcgFX6cCP15Rm0QPAcm3A0tRWAN/6FjwqtrafRrZ8lqi0Eyw4J3Ykqc9xZRhqrBkomfyWKRMEbM3CFoZgkyfhz3hgTdbVX8kNTGaxps4Y1s+9Llq0/jVVvGs16JYGPuj1W8JeU/bHEgN/pNI0j6njd6d3r08caPb5zY92vY7313ju+arNnWpIv9GYG" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=debug msg="completed challenge" Oct 25 06:38:07 volumio go-librespot[27298]: time="2025-10-25T06:38:07+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:07 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:07 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:10 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 227. Oct 25 06:38:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:10 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:10 volumio go-librespot[27305]: go-librespot daemon starting... Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=debug msg="app state loaded" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" 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 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" 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 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" 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 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=info msg="zeroconf server listening on port 42537" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=debug msg="obtained new client token: AAAeT2APxFj/0r9RR6Hu95+/OvduRrfjX48A4SD4WDdYqK/PpFuslVl/vFWwTcQQUoF0vm5HcpLfq68AvYJuJknIn+Zv9OFym3l5Jb9NyFig1zkiQmL18uK1d9xbIs8peYR+eX99xYg5M/4DgsCCGpSsSSCAatspUgJRwy2ebz+nSmsWDUrnwz8PAVQcmnjCr8b/uDPaigFBsrrMxXUFiVD4XaMU+KMALq4kbEObowXBPIXThVtGrSQ=" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=debug msg="completed challenge" Oct 25 06:38:10 volumio go-librespot[27306]: time="2025-10-25T06:38:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:12 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 25 06:38:13 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:13 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 228. Oct 25 06:38:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:13 volumio go-librespot[27313]: go-librespot daemon starting... Oct 25 06:38:13 volumio go-librespot[27314]: time="2025-10-25T06:38:13+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:13 volumio go-librespot[27314]: time="2025-10-25T06:38:13+01:00" level=debug msg="app state loaded" Oct 25 06:38:13 volumio go-librespot[27314]: time="2025-10-25T06:38:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" 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 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" 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 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" 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 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=info msg="zeroconf server listening on port 38649" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=debug msg="obtained new client token: AAB4rixI52W9XjmHrFGENg2GT/2p1C8ihMwNzNJqsyVHliI3G8ZcUiNBEe9izcc2nLfXZAB+tamHwrIH7u97vb+PoOWfcJy6qAIXCMvJb2tLbrSvKg6KqHhuPEtTBEpZgTYKvX3Y21u5bqtlFiXQ18HfzGbcHFAbKjcmDQ26HPvf6iPoJt+M0gEmvcUOs9tEqgjztYPEsH99yWwIlmTcvpjog87OJt/b3aihoQqGGHzTrRSH0wpz" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=debug msg="completed challenge" Oct 25 06:38:14 volumio go-librespot[27314]: time="2025-10-25T06:38:14+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:16 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:16 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 229. Oct 25 06:38:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:17 volumio go-librespot[27335]: go-librespot daemon starting... Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=debug msg="app state loaded" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" 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 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" 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 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" 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 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=info msg="zeroconf server listening on port 45325" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=debug msg="obtained new client token: AAA4OsbT12fhePHK5FDAZA4pHvfC1SOHJXb2ShYWCvnNo1JVWCMHNd1nXvnFrlt8dVmCsJBZIKM4Z5diN5KSwLQDgMVvi2d0+/iALCBDmvkTMFJwXXu96gAP9WZ7pe8V6Ar2PgygewmNg+cImdU0P5MJPtYcCzF+RqWnpTWBmJqLhUtaZaKpSfywiJyfy7qKgBgd5Yoh/7g1O6O1+QNQdlZxULFH/slHbkDhv4Ptc92BbvICSNultAI=" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=debug msg="completed challenge" Oct 25 06:38:17 volumio go-librespot[27336]: time="2025-10-25T06:38:17+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:19 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:19 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 230. Oct 25 06:38:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:20 volumio go-librespot[27347]: go-librespot daemon starting... Oct 25 06:38:20 volumio go-librespot[27348]: time="2025-10-25T06:38:20+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:20 volumio go-librespot[27348]: time="2025-10-25T06:38:20+01:00" level=debug msg="app state loaded" Oct 25 06:38:20 volumio go-librespot[27348]: time="2025-10-25T06:38:20+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" 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 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" 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 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" 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 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=info msg="zeroconf server listening on port 46485" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=debug msg="obtained new client token: AACVrOfymrTp5vuAsKA267YT6sNv5FzH8SvUG7sOlUJOvj0o9990BVXtwLTL2cpQ1hk+HVFxYsEtcoDE32sCjrzVmvR1H900a698eQfbvCTyLc0U2mc5O3yfmEd8SKnBtYr0ZIaFtA84lZptb5YJkU2z7JKaqBOu//QjSEV5KMKqwxCoYxVfsz7yus2tmuyb7K9/CUfzpjnYblM5xi0HPZ47JAMyL5f++xHTm1ckHQq0+ZCJFB1y" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=debug msg="completed challenge" Oct 25 06:38:21 volumio go-librespot[27348]: time="2025-10-25T06:38:21+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:22 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:22 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:23 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 25 06:38:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 231. Oct 25 06:38:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:24 volumio go-librespot[27370]: go-librespot daemon starting... Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=debug msg="app state loaded" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" 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 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" 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 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" 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 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=info msg="zeroconf server listening on port 39557" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=debug msg="obtained new client token: AAB5xRAnW8wbtVOKcSVJz2Lg0yy3SbbuPyZkxSHppA9DxXgyxwwRSmpQnE05lvyGO6CJ0M4JkO83xnEFcMBzEix8WiFob2FO7KE48vDAF3RgmuiVLXxvUfFqRe2Gs7cGyZYn5TQZrVHrYK/WpD8dzONhPO36OmsCfL+mqu3ftK1CZ0qZtfLbxl8T3vdBPwVhQ7i/jtvtvqTj0COI4BvrLtWKBwSeBvBGPblsepis5KmBZ4wOc9bJsxc=" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=debug msg="completed challenge" Oct 25 06:38:24 volumio go-librespot[27371]: time="2025-10-25T06:38:24+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:25 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:25 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 232. Oct 25 06:38:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:27 volumio go-librespot[27378]: go-librespot daemon starting... Oct 25 06:38:27 volumio go-librespot[27379]: time="2025-10-25T06:38:27+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:27 volumio go-librespot[27379]: time="2025-10-25T06:38:27+01:00" level=debug msg="app state loaded" Oct 25 06:38:27 volumio go-librespot[27379]: time="2025-10-25T06:38:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" 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 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" 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 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" 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 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=info msg="zeroconf server listening on port 33525" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=debug msg="obtained new client token: AABHdIRjJ4E8A47XdA3aXzkKbjUnkFhMpJLmc720qYR6STQrjKSg1FuOv32X7G6WA+btX4Slj59JYZvXrFgxNFgcobkDL7qrJrsFZS14CYOAswJ94GZ9UttagMBRvqXVWkZ2WYjmFdv0PP3qXbO15uH2oKqBt8ew9wCEAooBvo4aveZI538lGHrIGVnHrd2ws8gtNmthXaEYS/j2NjMJyDOQ9b27S5lRQtb7wQd0QOfV12N9+pN+" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=debug msg="completed challenge" Oct 25 06:38:28 volumio go-librespot[27379]: time="2025-10-25T06:38:28+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:28 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:28 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 233. Oct 25 06:38:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:31 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:31 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:31 volumio go-librespot[27386]: go-librespot daemon starting... Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=debug msg="app state loaded" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" 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 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" 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 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" 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 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=info msg="zeroconf server listening on port 34277" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=debug msg="obtained new client token: AABu//p465mSrxxXEUW7HtOQkF4WhVtkMrObBBhHNd61ALd/WskenmNIphatGVBk9wt+5RAY2fT7AWgdUOWitqiZAfbLbcJJSPWYCU8UDFUriOcSX9SQt2pZgGrShkR18ozB5NzEnIfHVujvKeE/WuBetXpjGZfGFoOxMVJj6MjeQVesvPQNkOakJJBCYgQlIhJb9oVf1a6a+tZGlK2x4f+ZwIeMzJCfzMPxmeKRMyMA0rtovCE6MxY=" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=debug msg="completed challenge" Oct 25 06:38:31 volumio go-librespot[27387]: time="2025-10-25T06:38:31+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:34 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:34 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 234. Oct 25 06:38:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:34 volumio go-librespot[27408]: go-librespot daemon starting... Oct 25 06:38:34 volumio go-librespot[27409]: time="2025-10-25T06:38:34+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:34 volumio go-librespot[27409]: time="2025-10-25T06:38:34+01:00" level=debug msg="app state loaded" Oct 25 06:38:34 volumio go-librespot[27409]: time="2025-10-25T06:38:34+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" 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 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" 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 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" 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 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=info msg="zeroconf server listening on port 37841" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=debug msg="obtained new client token: AAAynck8lTMBN/gqTNCjB8pMTcFMz2YlUBOVzk6GHMzxK8+/t0tVFcXlLDUFI1GQKzvNXJLd0o/DLCP1zMu3qg11rQ3HNOaHvGlUeFEPjrRzNAlmCFJdvWijfhBWcAN86CTa/5xmBShxRXpGc+PDckKHTRdH1bHVF0qJZvSe7tDTbtn++IxIcEQ+WX6E5zBk1ONv52jiX8GxaAsZKKPwYhqanhaNVsjFtIetiDDTpCDDHCSKEXh0" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=debug msg="completed challenge" Oct 25 06:38:35 volumio go-librespot[27409]: time="2025-10-25T06:38:35+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:35 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 25 06:38:37 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:37 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 235. Oct 25 06:38:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:38 volumio go-librespot[27416]: go-librespot daemon starting... Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=debug msg="app state loaded" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" 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 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" 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 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" 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 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=info msg="zeroconf server listening on port 44917" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=debug msg="obtained new client token: AAAOLKCVMno7WvmzWKU6Ht9qjyJp55h5wzluEHWp6dtFd4v6Wk3hrv/r8PKH/vZF67StsfO53OnclJL9YF01kWb/bEe0YpxWdPXcd5Me3pxHbxmHOPNnZ+1O1ScwUYy3IE6tnrq5X76vtpjEl7Uwxo264VojS8d/v1dplgpcaB+Fc7GQCShK5KkQ4sjwKHgu+E0S79hRIREqbBziNUOSnBbKh3mA1fDvof4w4Pcc2VDY46W3Bb9Rl5g=" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=debug msg="completed challenge" Oct 25 06:38:38 volumio go-librespot[27417]: time="2025-10-25T06:38:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:40 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:40 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 236. Oct 25 06:38:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:41 volumio go-librespot[27428]: go-librespot daemon starting... Oct 25 06:38:41 volumio go-librespot[27429]: time="2025-10-25T06:38:41+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:41 volumio go-librespot[27429]: time="2025-10-25T06:38:41+01:00" level=debug msg="app state loaded" Oct 25 06:38:41 volumio go-librespot[27429]: time="2025-10-25T06:38:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" 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 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" 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 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" 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 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=info msg="zeroconf server listening on port 33779" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=debug msg="obtained new client token: AAAi1gdH3dnSWgtdqxKRHhRK4WPEXEWxHN4AygNqtxfeXduX2KZMxZf5VsiI17px5kcaFOo4fzRG1qqfPEjHZz2m/ZlSvUnNE9qQ41bcU+sbkHe+v13G94LmdKjUjDyYZRc5eN0wQHm0PQ/Hsd2ltTtm+kZ9rv6IH9np0Qu1dVZLDVYoGb9RQQ8XtDtQqnfwGa2ke5qCTSkJyZjXm0zo/bsthGMJYhK5YP2NryWE9WOLFXnFUPuU" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=debug msg="completed challenge" Oct 25 06:38:42 volumio go-librespot[27429]: time="2025-10-25T06:38:42+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:43 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 25 06:38:43 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:43 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237. Oct 25 06:38:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:45 volumio go-librespot[27450]: go-librespot daemon starting... Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=debug msg="app state loaded" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" 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 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" 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 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" 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 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=info msg="zeroconf server listening on port 44449" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=debug msg="obtained new client token: AAD2MpxnL9rJCT9VDnRAXbGU9OgCAKPNQH4mHTGhBE7rWJBdiSGgAROpd67pU0Nw3V7XSarrV40i/6N7g87qNivmdRzZ3dLDDRppEW1B6m+R7JQwil8RGIQUeSlHWS1FJYuJ/aMlNkLLOwFg2WQgKBPlas1k1pTQk2+ZlH8MPP6RuPWWgEJYJaCpo2W+XNp2T0BNBKIQfPUKiyRRgLRPXwZ1pBt3te4u2I6JbtYtnCXoHiBjrhvdVDA=" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=debug msg="completed challenge" Oct 25 06:38:45 volumio go-librespot[27451]: time="2025-10-25T06:38:45+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:46 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:46 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 238. Oct 25 06:38:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:48 volumio go-librespot[27458]: go-librespot daemon starting... Oct 25 06:38:48 volumio go-librespot[27459]: time="2025-10-25T06:38:48+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:48 volumio go-librespot[27459]: time="2025-10-25T06:38:48+01:00" level=debug msg="app state loaded" Oct 25 06:38:48 volumio go-librespot[27459]: time="2025-10-25T06:38:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" 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 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" 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 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" 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 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=info msg="zeroconf server listening on port 34517" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=debug msg="obtained new client token: AADNoI8HzCQVu5LZcOO8AsNDfI8L+w0n4M4eLaeWrpF/R+YKkwJFUnKCzVFeb/Z52A5BKanvw21NPyQxrl7eiNT1PwMF0oMWo56GVtNfmgcUWERZT7TkxNcjLzDwk9NkKmywcBnftpkFHS/xV1Wqmuu24fT7RCmpOJkWknfkOw+K6jBKFbQ2fk02PXxZdBuEvljpqm5bXY2DFX6HEwCqR1ANhHfTgCZXOejNZv+fhW4niDpVfroH" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" 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" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=debug msg="completed challenge" Oct 25 06:38:49 volumio go-librespot[27459]: time="2025-10-25T06:38:49+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:49 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:49 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 239. Oct 25 06:38:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:52 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:52 volumio go-librespot[27466]: go-librespot daemon starting... Oct 25 06:38:52 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=debug msg="app state loaded" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" 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 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" 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 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" 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 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=info msg="zeroconf server listening on port 41375" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=debug msg="obtained new client token: AADg1av2vz2M326NeNLads0GplF44adac0ufTFjj0yJ9Mgg3pNPyykzdpd6aZIeuZEJcJsV32xzgAhCyn+pw91IfpBt4JNWgQBElZNqayX9vOoiNupiBjhNAA/vljge5dGjwE5VuHoShBC/jaBWL0eNbV4V7WBqx3MQHtpqavjTVwo0PZtDUPMw0lp3tWu/e/bgwaJlqIctGLqvKIghyJfFRQ8ELV8o8GZfcO4rkTwRlM/OHpEZwBcI=" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" 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" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=debug msg="completed challenge" Oct 25 06:38:52 volumio go-librespot[27467]: time="2025-10-25T06:38:52+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:55 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:55 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 240. Oct 25 06:38:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:55 volumio go-librespot[27489]: go-librespot daemon starting... Oct 25 06:38:55 volumio go-librespot[27490]: time="2025-10-25T06:38:55+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:55 volumio go-librespot[27490]: time="2025-10-25T06:38:55+01:00" level=debug msg="app state loaded" Oct 25 06:38:55 volumio go-librespot[27490]: time="2025-10-25T06:38:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" 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 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" 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 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" 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 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=info msg="zeroconf server listening on port 46637" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=debug msg="obtained new client token: AADTTbSOcX7uwbzRsJ19/bUvIPXQrmTLZPWnnY941VFWm1UIyCa+a9JIU0CajgyiHn4XfsI2gkCHkqDDfRTI47xURadIEHdjWV+gypL7gCftl2mVkVplAe4IXEO6017Iyif1yO2rLapmOIJxwWyg1ciVeqmV/iyCZAQgqDDSA34dJGsixs1DXg/FNxhtkxUz8wlAlb6GdNqKY68VAtZaa2tIQPOaSanpA3wW/+8AAuHiw8o03GJC" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=debug msg="completed challenge" Oct 25 06:38:56 volumio go-librespot[27490]: time="2025-10-25T06:38:56+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:38:58 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:38:58 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:38:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 241. Oct 25 06:38:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:38:59 volumio go-librespot[27497]: go-librespot daemon starting... Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=debug msg="app state loaded" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" 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 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" 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 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" 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 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=info msg="zeroconf server listening on port 33947" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=debug msg="obtained new client token: AAA+6zSRvTqDHhEPaeDc3wb7PBUS6eJEI3DALF3wPGEXkYWv8sHfI20hrsMCRX4N1W0rSHL3XIyF1C6MXqJx+57qhy2w6yF5oFYv48jL4S40Xz7E3DgVhWNtHJr3virMxUvahdD449zSJ8HlcfveXuewiX2eBatv+CGae1oqBNGcZHACEAXTJlPFnEanrexjSPPidWkRLY/1sIhgqP4k2uYQi8t5MZvl6dx0q6CREFtsDNVbHXLaN48=" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=debug msg="completed keyexchange" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=debug msg="completed challenge" Oct 25 06:38:59 volumio go-librespot[27498]: time="2025-10-25T06:38:59+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:38:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:38:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:39:01 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:39:01 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:39:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 242. Oct 25 06:39:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:02 volumio go-librespot[27509]: go-librespot daemon starting... Oct 25 06:39:02 volumio go-librespot[27510]: time="2025-10-25T06:39:02+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:39:02 volumio go-librespot[27510]: time="2025-10-25T06:39:02+01:00" level=debug msg="app state loaded" Oct 25 06:39:02 volumio go-librespot[27510]: time="2025-10-25T06:39:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" 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 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" 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 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" 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 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=info msg="zeroconf server listening on port 39659" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=debug msg="obtained new client token: AABY+DLXJJZZmwgWmWOIchUPwieBFmxLsLD43YUjeH/pqQj/ELiYVZCAuSUm8PoKooq+SYKb5CdX+AIgNRAbO5oxZ4divyJB299T532BoIPxwJlMOSfPHV954V9qQ2a+6/TXXq5JU2fgEORKYQ+vuh6DWQp1A7U3OG6aKDdLXly0J9D5GC7wKwFkX06djmsTZFXL5DShjQN/kTTGF1tUKxHf+NLFloKt7bn0x72Ig38NDonbUdwQ" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=debug msg="completed keyexchange" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=debug msg="completed challenge" Oct 25 06:39:03 volumio go-librespot[27510]: time="2025-10-25T06:39:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:39:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:39:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:39:04 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 25 06:39:04 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:39:04 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:39:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 243. Oct 25 06:39:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:06 volumio go-librespot[27531]: go-librespot daemon starting... Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=debug msg="app state loaded" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" 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 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" 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 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" 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 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=info msg="zeroconf server listening on port 44779" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=debug msg="obtained new client token: AAAnijIAWa4PGL8uekClvtUcQ+/0K3CIa1iXP6XR/qdS2WS5hhohtdQdkRh0emFf0rzklEOSoDkA/XCqFoRBe8urFwAMxLXdbOM/KlTytH6VkBjhEcNfusVpFzLYCn7r0eA0gPxmtfQbrQoxMtza5giAnKe6fnZCISNqA7JtWdrPd/xfptSlFO9N0juLDzvsMeIOj4YsRPD1aqzYgtdaj4y5GzVr1DC7XqTACd0KTNCVJcmCwHOPyBQ=" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=debug msg="completed keyexchange" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=debug msg="completed challenge" Oct 25 06:39:06 volumio go-librespot[27532]: time="2025-10-25T06:39:06+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:39:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:39:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:39:07 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:39:07 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:39:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 244. Oct 25 06:39:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:09 volumio go-librespot[27539]: go-librespot daemon starting... Oct 25 06:39:09 volumio go-librespot[27540]: time="2025-10-25T06:39:09+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:39:09 volumio go-librespot[27540]: time="2025-10-25T06:39:09+01:00" level=debug msg="app state loaded" Oct 25 06:39:09 volumio go-librespot[27540]: time="2025-10-25T06:39:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" 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 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" 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 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" 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 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=info msg="zeroconf server listening on port 40507" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=debug msg="obtained new client token: AACG4etczSkqz9Y5elTDnqsmIy5tcw/Z8/cRQjfXN4obUfA2vMMjTkkknYdiJSgCb4f5ZXNDgPIRtbFN01awsBhVVVuyQgu5C9DZeeybrI0/kOW8A1UkLzL/+28Ep3HSGMSskKqJvf32EnFSXfWA7IcGeFNCMR8qbtLEwRU/t0QKrKCsy0ZZ3+zCJse5KNCADZFM9JFdYhMw9HQC0HpBWLDVQE2rixAv/uvajuhbkA72v7ba2gBw" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=debug msg="completed keyexchange" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=debug msg="completed challenge" Oct 25 06:39:10 volumio go-librespot[27540]: time="2025-10-25T06:39:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:39:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:39:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:39:10 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:39:10 volumio volumio[26132]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:39:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 245. Oct 25 06:39:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 25 06:39:13 volumio go-librespot[27547]: go-librespot daemon starting... Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=info msg="running go-librespot 0.4.0" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="app state loaded" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 25 06:39:13 volumio volumio[26132]: info: Initializing connection to go-librespot Websocket Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="new websocket client" Oct 25 06:39:13 volumio volumio[26132]: info: Connection to go-librespot Websocket established Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" 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 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" 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 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" 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 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=info msg="zeroconf server listening on port 40611" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="obtained new client token: AAA7pO4J5KGXOAu3AcHfkRB5+ML8Y86rvC9DAzgaoHKBcINhuv5AnPWPk6O8uHLEfsNSBIcShleLdxuQhHdIS18xfH1wyNAOXPBYCE7y7G6pAAN3hLO7CX/MDIx7Eo7rZZvIlM3JPEtKK2QeA5XfDOjf74Kiu2K7jDVZzaqKDxJy8PbdvfcnlETpgsgNyBQ8RUsPhlFQEvoManNWNx4RnANjlb8U6XJx9HQvSw7gcFsYhlB5tFotiw8=" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="completed keyexchange" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=debug msg="completed challenge" Oct 25 06:39:13 volumio go-librespot[27548]: time="2025-10-25T06:39:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 25 06:39:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 06:39:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 06:39:13 volumio volumio[26132]: info: Connection to go-librespot Websocket closed Oct 25 06:39:16 volumio volumio[26132]: info: Getting Spotify volume Oct 25 06:39:16 volumio volumio[26132]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 06:39:16 volumio volumio[26132]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 06:39:16 volumio volumio[26132]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 25 06:39:16 volumio volumio[26132]: errno: -111, Oct 25 06:39:16 volumio volumio[26132]: code: 'ECONNREFUSED', Oct 25 06:39:16 volumio volumio[26132]: syscall: 'connect', Oct 25 06:39:16 volumio volumio[26132]: address: '127.0.0.1', Oct 25 06:39:16 volumio volumio[26132]: port: 9879, Oct 25 06:39:16 volumio volumio[26132]: response: undefined Oct 25 06:39:16 volumio volumio[26132]: } Oct 25 06:39:16 volumio volumio[26132]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 06:39:16 volumio sudo[27583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-25 06:38' Oct 25 06:39:16 volumio sudo[27583]: 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"