Oct 28 08:30:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 185.
Oct 28 08:30:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:00 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Oct 28 08:30:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:00 volumio go-librespot[22072]: go-librespot daemon starting...
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=debug msg="app state loaded"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" 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 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" 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 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" 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 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=info msg="zeroconf server listening on port 40307"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=debug msg="obtained new client token: AABkzKlCUAiERM4Mc+OPr/A2YSW6pNe0ZVPYYkeAfHMVEzrRtpB+Q78qWSjzV1OmznWhUMbLuaB/GB0wJdPUer0KhZJeNyUetdgiv5c8nTBnyrnwDwdQ1nlZ1yYkEGFDwDdaulEBZiWA5jEkZoaAU/jfES2DDGOw7a1NqpTvfdxb21ZJ2HYLmDv9E9Ggozk+dbpsy9uigw4XI+DDKXJ8K2cKxKZdak60qRn5DPOp1rkLG+XIXA9XjLI="
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=debug msg="completed keyexchange"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=debug msg="completed challenge"
Oct 28 08:30:00 volumio go-librespot[22073]: time="2025-10-28T08:30:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:00 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:00 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:03 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:03 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 186.
Oct 28 08:30:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:04 volumio go-librespot[22080]: go-librespot daemon starting...
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=debug msg="app state loaded"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" 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 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" 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 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" 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 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=info msg="zeroconf server listening on port 34779"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=debug msg="obtained new client token: AAD+rWRgEecH3c5pnQxciqkkY5eyt75eBPxo4xdVog58wTxNtdavjTDTiUtmstaRa3+C2tkJdQQSuLBKSREh1joWfqd2SDn3MOCr16jM1FADKSRckdiHbnhZPKacCm3v1icbLlIprMFHLiCE4gYgp/ojrp7+9u8mxewv/YZhyp6sgnttYxb2cMj/3bDpuTDpt80NtjW8QsSY22+p6s2V2ustdj4+SvPLCeWxK4jBcU2toeRdFn/S"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=debug msg="completed keyexchange"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30:04Z" level=debug msg="completed challenge"
Oct 28 08:30:04 volumio go-librespot[22081]: time="2025-10-28T08:30: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 28 08:30:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:06 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Oct 28 08:30:06 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:06 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 187.
Oct 28 08:30:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:07 volumio go-librespot[22088]: go-librespot daemon starting...
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="app state loaded"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" 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 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" 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 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=info msg="zeroconf server listening on port 39625"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="obtained new client token: AAC26bb09j8G2tVm6/H+GbN89DNfgoSI2b9sq9F2Haun0mZX3VoEqp0WWz8XO+ZzOc3cMUH/Zb3H1f2vgnjMoiSgmfp1Co6HBZNDASzkUc4tvGsOIDlVPJIhUaY6JozWz5kE/SjY8PZ0V+thgAqc5IQ9Y8QoTKfr48Te0rcCO2xvstHc/+l2bni8Jr2oPM1op1kOtTAcwkoFGjEeN0ZE1grDYUIq8cxu1WoKOzEOAlwKaAW/lCofE/I="
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="completed keyexchange"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=debug msg="completed challenge"
Oct 28 08:30:07 volumio go-librespot[22089]: time="2025-10-28T08:30:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:09 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:09 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 188.
Oct 28 08:30:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:11 volumio go-librespot[22110]: go-librespot daemon starting...
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=debug msg="app state loaded"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" 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 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" 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 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" 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 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=info msg="zeroconf server listening on port 36493"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=debug msg="obtained new client token: AAA8C0EtxmZl1MCmM6/9rBoDwKQyR94jCs3HpGSQzdzdFX08z14l//SpmdvyYUjm4ETYyHj4cD4p5Cw8h5c5h1bP6TrYUcXvj9+Jys2c89y4y3nXbpzb+N3YgyiAd57PUQnA43uJp8EShP9DmjV7d+/fVae3B25VN03mnyTVcestPbPZqFzHXV3R7Otg8DRY+uR4a2tfiFg8oGQVx2bgpc7Gn3dHTYIk5JkO1fWuva6HoLJuXwkY"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=debug msg="completed keyexchange"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30:11Z" level=debug msg="completed challenge"
Oct 28 08:30:11 volumio go-librespot[22111]: time="2025-10-28T08:30: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 28 08:30:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:12 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:12 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 189.
Oct 28 08:30:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:14 volumio go-librespot[22122]: go-librespot daemon starting...
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=debug msg="app state loaded"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" 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 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" 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 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" 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 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=info msg="zeroconf server listening on port 41873"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=debug msg="obtained new client token: AACMaufbPtx69chZaYoJaprOH2EVoyLI0aEMMVV2h5dbsRmlQYesjq1h8/YjInXG6I1N5qsLFplsT0l8yOBTp0a4ya10RsWWIAFjIDOxX6I0ECP06yBH1+ZepMKwTws9h5ULBP3i1L279GVMGDrPIF2nsRuTmyeoThxvSKvv5ih49jp8KO6Z2RegEcr8OUI7PWC0QSRtvBn9UzHlRYb2SJjGRbMMmS0zvSi36jx6cH9mnOzwUZQnoeI="
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=debug msg="completed keyexchange"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=debug msg="completed challenge"
Oct 28 08:30:14 volumio go-librespot[22123]: time="2025-10-28T08:30:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:15 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:15 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 190.
Oct 28 08:30:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:18 volumio go-librespot[22132]: go-librespot daemon starting...
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=debug msg="app state loaded"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30: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 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30: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 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30: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 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=info msg="zeroconf server listening on port 35191"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=debug msg="obtained new client token: AAD4AlovWC6IJrdgUda0oWHgdEYgYg5hk0pMNZjvvT5It0623ynjwesd0zs5EoWYrFRpLWJhiEMOCYk8++NdcV00ABw1hNcp+W8LH8K0shTdnPS32BWA4TIxah+cf2xTTmiiEcmKTpWF0sGmYS+cQaItF3G39T1oRxEraOsgswL3gCnkIrOmWHU1b4OB83UfnpxRYDH/OgbhUgIJXkVeiHlVLrPTXXqQrMX1GlJP4Ympb3emk2ij"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=debug msg="completed keyexchange"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30:18Z" level=debug msg="completed challenge"
Oct 28 08:30:18 volumio go-librespot[22133]: time="2025-10-28T08:30: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 28 08:30:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:18 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:18 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:20 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Oct 28 08:30:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 191.
Oct 28 08:30:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:21 volumio go-librespot[22155]: go-librespot daemon starting...
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=debug msg="app state loaded"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" 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 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" 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 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" 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 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=info msg="zeroconf server listening on port 43661"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=debug msg="obtained new client token: AACNN+QLwdSYRzaIhYDOOHFWTOgLuczdaJlyTlF5LVJVxvOH6ivKeXgMASN4dDC4jvtgX3NJ7BnKcl3Yafgj1VqHwYxR+ieOs8hE009+Z15OBpbJugQ288i9jGWUIpIuEM5fiYUFcvE75kD7Rt9qB55RafU4bJBkI9RHA9LPgnPg9Llqj9h6evkk3k/a4IQvL5OcxaAWTtUHlSgjm4WaxtoixW8ZSJql3WsvlspeMH3y1snbQtWWX7Y="
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=debug msg="completed keyexchange"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=debug msg="completed challenge"
Oct 28 08:30:21 volumio go-librespot[22156]: time="2025-10-28T08:30:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:21 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:21 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:24 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:24 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 192.
Oct 28 08:30:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:25 volumio go-librespot[22163]: go-librespot daemon starting...
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=debug msg="app state loaded"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30: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-gae2.spotify.com:80]"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" 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 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" 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 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=info msg="zeroconf server listening on port 37387"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=debug msg="obtained new client token: AABPTUBn6JM3/sUjsiYtlr/r9wgc3FEVhkhKR9YNXh3o1Llcy553livvYNdTnvUznJGoBRIynILec2X5gZ9kKYjueuj61wFfTMWEwCNRwVJghg+7pM6nQ3AbKLCABrHQ0AZU6Oemxg4a/ko27yIyJfB/fB4KdzJaFqsy+qp1AaEsHucOnhNHCbsvo3rDR8SMVB1FKP9z0x9MA8SlIvV+kghFqGJ9D86/ykrC8rr7DKqFyt789T37"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=debug msg="completed keyexchange"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30:25Z" level=debug msg="completed challenge"
Oct 28 08:30:25 volumio go-librespot[22164]: time="2025-10-28T08:30: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 28 08:30:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:27 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:27 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 193.
Oct 28 08:30:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:28 volumio go-librespot[22185]: go-librespot daemon starting...
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="app state loaded"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" 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 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" 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 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=info msg="zeroconf server listening on port 44277"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="obtained new client token: AAA9JwjO+ZVWSff2pTrrhXRJoIwbWLShcO2eBO7vWtguiwXO5TPXocnFfxJDvyeUjT0q5wUaKOetz8Hi69pEshe4B7WLljCxT2BBUshlpnhdOXPoryLQgnCFmYVsr6U3rvsg/2AzDjdEXBkG5pMve7qt5Rt2OslU1+OKWgy8S2aSNmLegEg/pGNTWAvnzk9HeVZ8NTcQccgMMEyPPdy7vOwhtblTDqW11WtWO8OnTS8QRRup2+4u/Do="
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="completed keyexchange"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=debug msg="completed challenge"
Oct 28 08:30:28 volumio go-librespot[22186]: time="2025-10-28T08:30:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:30 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:30 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 194.
Oct 28 08:30:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:32 volumio go-librespot[22193]: go-librespot daemon starting...
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=debug msg="app state loaded"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" 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 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" 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 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" 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 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=info msg="zeroconf server listening on port 42927"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=debug msg="obtained new client token: AADDgbY8fcbPW/esDJU+k+wUkWCo34P+Kh8JJDuxjKFpCD861ago4p+rS4TvZHD6bmLJgWJ8sC+uJaINR8Vc7B+nemKSt/7vRB5hoQaMjz/LRwnydKFPQY/9tCXHJtrsHK+b8ly49doZBWyogNVTMU8kRRNMdNT/8zmDt4bwM8co/RT8b7jT+JwxZI0m66ihUUg9DPLtiPz6X6h1VZk5nRelSttYtv1k+Fx4t3rmfoSw5LN/bSC7"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=debug msg="completed keyexchange"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=debug msg="completed challenge"
Oct 28 08:30:32 volumio go-librespot[22194]: time="2025-10-28T08:30:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:33 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:33 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 195.
Oct 28 08:30:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:35 volumio go-librespot[22205]: go-librespot daemon starting...
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="app state loaded"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=info msg="zeroconf server listening on port 34717"
Oct 28 08:30:35 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="obtained new client token: AADiClcMl6yxQbvHpis1/LKssyvmWerUaGKPyFyfLyXBEaCR+Ghgi/fKGYnLsSA4dls0WpngDHZEcBmdMZSxVXTHPVz3h/eNLW5Cr42RtCTcxnEi7Ax9EPD/fsppQT+j3p26BnR63w/iwQMm0FXtEb+TXIwqFBOQxbDM4GdEsDoPwjPeKBgu7yrSSY1pAK87tPTsb10EjNiJMx2dvze3aTkEoydYaQlv9YMY9pw4Bq2SAxvFLjET1AY="
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="completed keyexchange"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=debug msg="completed challenge"
Oct 28 08:30:35 volumio go-librespot[22206]: time="2025-10-28T08:30:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:36 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:36 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 196.
Oct 28 08:30:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:39 volumio go-librespot[22227]: go-librespot daemon starting...
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=debug msg="app state loaded"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" 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 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" 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 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" 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 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=info msg="zeroconf server listening on port 33435"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=debug msg="obtained new client token: AAALqtj13CMWw16Vx55pcEYphNNxEeEK4dbWUZtk8416j1/iUyxKbmXqFgbG658UvX2XiZEgGf9DshpTJDInkAunj3h3E7OnYZT/1/mAZleGse9YafQY68xjeM8JrbSE8Xmhlg8kDP4WYaut6q1gMKli8u+23GYVwfktUWuAQnSLE5UYEKsmllRNIEAdAOA9K2jFRe+nEqBSb+EhMEzZci2o3dgQX3l7+5l183Pn5i9n4A75uTA/Tr4="
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=debug msg="completed keyexchange"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=debug msg="completed challenge"
Oct 28 08:30:39 volumio go-librespot[22228]: time="2025-10-28T08:30:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:39 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:39 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 197.
Oct 28 08:30:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:42 volumio go-librespot[22236]: go-librespot daemon starting...
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="app state loaded"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=info msg="zeroconf server listening on port 41205"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="obtained new client token: AABcIFWKXwt0muLzSuAWJ5920L88L2pW8FN2vm6KwZWY/Hiy/mWu7iMRb9rVpJZ9I3jCCupBZvCk72/kVlCPUIAqoJiUa/wyuGRaEGuRs5hH4EJNgHSWtoGrihHhaKkpuH+FK6nHDoh3eg7bhBROnHsohBajyJOMSbGR0jcHpKJK1dHy08ekWNRRfi2OEACa6mGSTPdxXw+3hPZPRU1CUUsFSyUFPfS/ThON4VdC0+pnKNCQK507o14="
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="completed keyexchange"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=debug msg="completed challenge"
Oct 28 08:30:42 volumio go-librespot[22237]: time="2025-10-28T08:30:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:42 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:42 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:45 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:45 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 198.
Oct 28 08:30:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:46 volumio go-librespot[22245]: go-librespot daemon starting...
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=debug msg="app state loaded"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" 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 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" 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 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" 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 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=info msg="zeroconf server listening on port 46775"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=debug msg="obtained new client token: AACUxZ34rqzpd+XrD9RXBBn15BQ4Bw45a6ffddel/8rS5olxocWboRNBtCsQTf3dSDD5VgqAs5++3Td7Xmo17NZSfSP1WfWGUxmFMVgrgkO/hjVX7FDBYswcEsEZqX1gbBK6Wya9mMxdl2UGioBz/K9RAwf7IJeJWE7UlJncuRcE0O6HQqPh136jikSidGbZIPkaj1gwHyWyh/p1Hlp3zw93wsmOpa6UQseLuif9U70KJPJacaLTmxk="
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=debug msg="completed keyexchange"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=debug msg="completed challenge"
Oct 28 08:30:46 volumio go-librespot[22246]: time="2025-10-28T08:30:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:48 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:48 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 199.
Oct 28 08:30:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:49 volumio go-librespot[22269]: go-librespot daemon starting...
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="app state loaded"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" 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 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" 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 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=info msg="zeroconf server listening on port 34613"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="obtained new client token: AABeJReWAfU7yr+xGU4RdI0aja5KRsSsWwaInSrdUINutCqjjqmqt+ihHkYVJo/DyOWljeRQbJoon3jGTdGIShownbWd1iH6mYboQ7xD15nTrt7fvlNw121PHMABdVke4es0yzRAitWsI4pf5pwFKBIKvnwhxdxse1oVnJGvcfTMhhMarGg1O0HLxhwW/qFhXi0L4OJMNNNX5EK90GaufNFO5fuKA48DEliqDBrTCap47G8JSvrZnaQ="
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="completed keyexchange"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=debug msg="completed challenge"
Oct 28 08:30:49 volumio go-librespot[22270]: time="2025-10-28T08:30:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:51 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:51 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 200.
Oct 28 08:30:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:53 volumio go-librespot[22277]: go-librespot daemon starting...
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=debug msg="app state loaded"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" 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 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" 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 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" 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 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=info msg="zeroconf server listening on port 39795"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=debug msg="obtained new client token: AABfCJ6wbayfWtLmBBdKPV+e2glyCAeiCU+NoP9je2JEgWJrR2EiglxsSD79vYYYDbu2DfuCMdjWSJA30Ad1bBA8/g7SMzryaeFLi0WVtCtpj378kyuKegCBoRGxnRYV5q11VjQtcAWUCdtw7brtCQivx2Wln2y+WN3SeNusTR2AmKgkF78O+/MhBL6/ZGZL8kduU1hE5eceMYnhBFlDC2OoGzwB1jhpezpKhnnltWytZIUPdGzQ"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=debug msg="completed keyexchange"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=debug msg="completed challenge"
Oct 28 08:30:53 volumio go-librespot[22278]: time="2025-10-28T08:30:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:54 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:54 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:30:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 201.
Oct 28 08:30:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:30:56 volumio go-librespot[22288]: go-librespot daemon starting...
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=debug msg="app state loaded"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" 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 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" 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 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" 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 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=info msg="zeroconf server listening on port 33365"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=debug msg="obtained new client token: AADnDba7gg0132BeKSJUKeJbl3RoIcOxKhhTOrZW0ZXKFzWF2z88qTbj+XsLAreOmdH6jb8Sy7XrFzjqa7ujaXJdfePtg0q7SrbgWpaqX/QuWyPTTC016YNZ5fRsFAFdAjxCt6ZuZrkuyMn5R70Q69axLYwF9vnuOnsDmJDOt0bIf9txYwthGBiZCfxGEm8u3PxeeGs+r68kY4xAOirUa7o5Q+GnmNN/dUkwR9h9OwZZHpnCXTrOQSQ="
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=debug msg="completed keyexchange"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=debug msg="completed challenge"
Oct 28 08:30:56 volumio go-librespot[22289]: time="2025-10-28T08:30:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:30:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:30:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:30:57 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:30:57 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:31:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 202.
Oct 28 08:31:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:31:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:31:00 volumio go-librespot[22310]: go-librespot daemon starting...
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="app state loaded"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" 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 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" 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 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=info msg="zeroconf server listening on port 34537"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="obtained new client token: AAC5o4J34jSOzEHolHMKRRR5by4AVy2k2QndJQopLa0gHILlnFD+oIQLzcXBYG3x3LVArP8RZxVgPWN5Z+yur7tvNLx0b96WctKioYUVUimhCP376ZsQLKrRj2sWv0/BXFjTIdWJQVFkjRXEWb98aPEW8aAdePdWp7R5qofVSBwptqOmXRkp2iF3znEopFgkL2RrkFlhdG0e6JGvb9I3AJQpIeCiWX0E+l7wCyZrpHXBxIZij751yM8="
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="completed keyexchange"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=debug msg="completed challenge"
Oct 28 08:31:00 volumio go-librespot[22311]: time="2025-10-28T08:31:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 28 08:31:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:31:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:31:00 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:31:00 volumio volumio[20902]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:31:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 203.
Oct 28 08:31:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:31:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 28 08:31:03 volumio go-librespot[22318]: go-librespot daemon starting...
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=info msg="running go-librespot 0.4.0"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="app state loaded"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=info msg="zeroconf server listening on port 33045"
Oct 28 08:31:03 volumio volumio[20902]: info: Initializing connection to go-librespot Websocket
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="new websocket client"
Oct 28 08:31:03 volumio volumio[20902]: info: Connection to go-librespot Websocket established
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="obtained new client token: AAB2vdNbXsJJp4t1oSBkK6LtEH5+2NYrSO4fUW6Lwq63aHAJ/WeUlgJnh4YLSd7i0MG6qAle/rltv+2ujWQpj8bXS7nBQw7OAeCeAxfInRM1FMMl358FRQMYCdUgfvPhCVqZX+2IctPmO5L/NLOvmE1zP0wXTk/R4eyE7ICxt4E19Je1TPxQTy3TGYyoqjPIRHfi61rMHw+f2c+cCLR3angHrxCp9k2ZhN2D8CfQsbfHog34o8Q66Yo="
Oct 28 08:31:03 volumio go-librespot[22319]: time="2025-10-28T08:31:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 28 08:31:04 volumio go-librespot[22319]: time="2025-10-28T08:31:04Z" level=debug msg="completed keyexchange"
Oct 28 08:31:04 volumio go-librespot[22319]: time="2025-10-28T08:31:04Z" level=debug msg="completed challenge"
Oct 28 08:31:04 volumio go-librespot[22319]: time="2025-10-28T08:31: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 28 08:31:04 volumio volumio[20902]: info: Connection to go-librespot Websocket closed
Oct 28 08:31:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 28 08:31:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 28 08:31:06 volumio volumio[20902]: info: Getting Spotify volume
Oct 28 08:31:06 volumio volumio[20902]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 28 08:31:06 volumio volumio[20902]: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 28 08:31:06 volumio volumio[20902]:     at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Oct 28 08:31:06 volumio volumio[20902]:   errno: -111,
Oct 28 08:31:06 volumio volumio[20902]:   code: 'ECONNREFUSED',
Oct 28 08:31:06 volumio volumio[20902]:   syscall: 'connect',
Oct 28 08:31:06 volumio volumio[20902]:   address: '127.0.0.1',
Oct 28 08:31:06 volumio volumio[20902]:   port: 9879,
Oct 28 08:31:06 volumio volumio[20902]:   response: undefined
Oct 28 08:31:06 volumio volumio[20902]: }
Oct 28 08:31:06 volumio volumio[20902]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 28 08:31:07 volumio sudo[22340]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-28 08:30'
Oct 28 08:31:07 volumio sudo[22340]: 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"