Oct 29 23:20:01 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:01 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Oct 29 23:20:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:02 volumio go-librespot[20310]: go-librespot daemon starting...
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="app state loaded"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=info msg="zeroconf server listening on port 35877"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="obtained new client token: AABm3448/rmPeXZpDG1Z5X98NHhHxzVgGXyLIOT6tHiqen7MLcmg+z6vSPFsfGe+5/yZICMuUa5/UqZKfuV1ZjeR1qt84mgDn/uPtR5UbjCQRgpJsoqmsCZqJYB23+KKxCeO0wxB2e4FtXU3wrR3QLaGXT1QqlAMu/WG4KIZZ3oHWxLvXyLJgEDrY2OwG52eIuuQDebpONCikPoIqgB5w8ZKGrng63wX3rJDz52vcsA2kddHnuHIpqY="
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="completed keyexchange"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=debug msg="completed challenge"
Oct 29 23:20:02 volumio go-librespot[20311]: time="2025-10-29T23:20:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:04 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:04 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Oct 29 23:20:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:06 volumio go-librespot[20332]: go-librespot daemon starting...
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="app state loaded"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=info msg="zeroconf server listening on port 40545"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="obtained new client token: AADOvfiiAp4xtuygTe9oE0nLYlS/V3uGDzPIVISVt+ciHZvQq+/7aDWiCqviALb60hYLa4h/VTf1LnJS8Ixz9sg6Gg1JeN45o2Sz3N5NXkDeexMdkEmPtr0We+AqQHKtz4Oc1UbGIXXzXQSUKw+vv0XAgwOyDDE69pqc/j+ncclvj+BcGzZlkAAhw6thbxhhezz/WtRTDizOXfiVncbzfiVBUOI5rOR2nG2x3B8us/bkrt1QJLW/"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="completed keyexchange"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=debug msg="completed challenge"
Oct 29 23:20:06 volumio go-librespot[20333]: time="2025-10-29T23:20:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:07 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:07 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Oct 29 23:20:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:09 volumio go-librespot[20343]: go-librespot daemon starting...
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="app state loaded"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=info msg="zeroconf server listening on port 37043"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="obtained new client token: AACNqY+mF1IahbXysG91WMfQhtKLbeeSCQHAte77nP4d4ZukZaVg0/DNY1pFx8lXGdMjZrXAcpMXxqHUgnQvw2VGB2jb5oUSncm2DGtRkL0soZTr5a6T17g6GMJu/BunsdkwWybaOF4QpOvB7L1wk8lJueYgZD6STUkakLIF26hlox7phiZdR1chiPgAgvMBtSreIuVeRv3UZbKkPUjvlCBd7QuhuEba40ZOWqEjMJ4uUz/PSk+m2t8="
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="completed keyexchange"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=debug msg="completed challenge"
Oct 29 23:20:09 volumio go-librespot[20344]: time="2025-10-29T23:20:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:10 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:10 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Oct 29 23:20:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:13 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:13 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:13 volumio go-librespot[20366]: go-librespot daemon starting...
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="app state loaded"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=info msg="zeroconf server listening on port 44481"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="obtained new client token: AACR2p0CE9Vd9TujHUNKk2XAOviqT/rBbSQEUh2jwrsvhucwYn5mU4ffqbExcm+huNlSYH+Y+Q0tFeddzZoPMKoOh0t4+Eo9f0CU1Ip7UImxhSxfdRMgtL0k/h1o3j1mJDzJyRV4LoT7M+fnIAL2XMFqbFwovf20Yv2qK1lAVuANVQ458atQ/P/kw4WomfWH7CLst1o3q9daqNITkhN3S1m6Ql63izJhwsXnZQ5dNTOZ1St4AiyC"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="completed keyexchange"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=debug msg="completed challenge"
Oct 29 23:20:13 volumio go-librespot[20367]: time="2025-10-29T23:20:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:16 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:16 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Oct 29 23:20:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:16 volumio go-librespot[20375]: go-librespot daemon starting...
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="app state loaded"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=info msg="zeroconf server listening on port 41619"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="obtained new client token: AABaWvyOovlYodpwuvJ58Z8Xe2T01Qa0+mWE9PukCAnFLol01rLzPHDKeL0tk+EgD/ZpjfcU7GOL4H2tTUfwAgnau4EgsKnXecPzd570QQk+sLyR4vXamQd5FnRi5McxG4j7BBD6cIcW/hesGUkVBKvh9kcLJbZ3o25RABVi3JmkhgjCP78UPm6bRMPNmmztoqhmpVQszF80QKO9pbWoHlr0gog7y1PDd7ukV+xpewTfpTuFDd8YaBw="
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="completed keyexchange"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=debug msg="completed challenge"
Oct 29 23:20:16 volumio go-librespot[20376]: time="2025-10-29T23:20:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:19 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:19 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Oct 29 23:20:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:20 volumio go-librespot[20384]: go-librespot daemon starting...
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="app state loaded"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=info msg="zeroconf server listening on port 35043"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="obtained new client token: AABvsc/8y9dOIsSQ71qEA3g4sbtmPYLF+gdHG+x+c6dgCCYEBql0X0lgwtaGxlwuHI5fzzbHqbPUaMfwVnQJBHhagynqTgagqG+t+p5wcqqD3S4T3NDjJPsV5f2cKQKXcDIBxyuiv0PknCCpkN+m7UQl6vBYFNiqGpzKjyBF/cC1vZC/bIN3udwAryYwz1jPTRKcZPZRA0Fstqie81TuInf1Entg+0qIyszaUA6rSxA/S1tBvJ55"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="completed keyexchange"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=debug msg="completed challenge"
Oct 29 23:20:20 volumio go-librespot[20385]: time="2025-10-29T23:20:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:22 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:22 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Oct 29 23:20:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:23 volumio go-librespot[20406]: go-librespot daemon starting...
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="app state loaded"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=info msg="zeroconf server listening on port 38091"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="obtained new client token: AAAMKptoMKvl5LI16xvIMoh4Ez5qKOXrVyz01tAX0G+GZlEQBs8EYMcLJ94/VsAuk7W3FrnL+DlhGBU4fxGbcRQkal3GGABZIrjDYP/32zGSlcdTG6xy0J3Z8iRPUR6D+recUHbwk/vOsGKHV308dp8amRSSjq+BPOV9WhRiUA6np3LX5lkoQfwwDKKxo6myVRnnLDGXNREBXCFFtcwXvQgphhLDuMIVD+Jndqm+ulZg3T9wPpntn8E="
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="completed keyexchange"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=debug msg="completed challenge"
Oct 29 23:20:23 volumio go-librespot[20407]: time="2025-10-29T23:20:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:25 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:25 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Oct 29 23:20:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:27 volumio go-librespot[20414]: go-librespot daemon starting...
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="app state loaded"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=info msg="zeroconf server listening on port 45025"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="obtained new client token: AADq/44B0H7kSa/MVpBlZMp4U+ULHqGymwxXoNsOIUThS0FfOJQOqTLcv2O3VkoP0Qnsf5KseebS9h1nBxPebbDwAZYdsztpM5vkDYf7Fnz+zi2mNM3Hr4piJaZbXgfcWmNHKjyEBlxhKYUhvvmea8AyNFKbROe24bfc3MLiDoRqVUufZXy5yjg+9L2hgJE3PdzMqIqItZBKiJjOXx/JArnbAc8ImtrLSmIQ8qEpT3L/xsaVFWKg"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="completed keyexchange"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=debug msg="completed challenge"
Oct 29 23:20:27 volumio go-librespot[20415]: time="2025-10-29T23:20:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:28 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:28 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Oct 29 23:20:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:30 volumio go-librespot[20425]: go-librespot daemon starting...
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="app state loaded"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=info msg="zeroconf server listening on port 42887"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="obtained new client token: AACdLXUIBQbzFvRVo5qTPQU58ObJ+ThiC/gf8KayPvivQsY5qWLkhN1oCQNDQnepqHQoqovjdejmweimgyda/UrAgDw5XqVifdNxdwpb5H2fvPDVt5bK73FkByDEyakDqT6P7oa/6qTnVKDZJ6qslYVipugT8zDBr2mAslPknUftcvl46jhEgQjbvOqpktf0eTxHWw3V1TY9u2akR7LK7/3hRup5mhFN2ZkesQ/TBnJ0JutyVKDikXA="
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="completed keyexchange"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=debug msg="completed challenge"
Oct 29 23:20:30 volumio go-librespot[20426]: time="2025-10-29T23:20:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:31 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:31 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37.
Oct 29 23:20:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:34 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:34 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:34 volumio go-librespot[20448]: go-librespot daemon starting...
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="app state loaded"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=info msg="zeroconf server listening on port 35791"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="obtained new client token: AABNvF7uLjlIa9RstT/R5HWneFYDO7gr6P1Xr9y518eMiHCrIi3jC68uLH1zapJyiPu8DaURL2veJP4DvdYu5btASy0qZcd3jP4BI8tGVNA19oOhw2tEo5Hx7BmKF/qsPrRNF2SNgvLQhrIytNSBPPBBCbf/XNAjrHW0Dx6yfQimJToypCnBNFS+64/39L/4SPNRZyQFuwkWRFxnJJEDVVlz1nHQoGlYdAUmGNxvI1UrLlSyZQ3W"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="completed keyexchange"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=debug msg="completed challenge"
Oct 29 23:20:34 volumio go-librespot[20449]: time="2025-10-29T23:20:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:37 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:37 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38.
Oct 29 23:20:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:37 volumio go-librespot[20456]: go-librespot daemon starting...
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="app state loaded"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=info msg="zeroconf server listening on port 34303"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="obtained new client token: AACINvyyKdF3tnm1w9BlGaLD0shEMqCGhJFIUfCQESEV8WkvK2srxgbnEBBBAJJdLcHbotwMvktdyhVifPqgUS1cP4CZybdt99fcKXcSjcIaZoCWgDoTHTu//yaF0U6rUIyuY409ECDDaEVtGHsUi3oQdQC79jAyt0Tr52aGoiFv30Fo4xYor0Y5tKnyj5ZNFTuFr52JKcItQ/P6Stgn8k2FrILeWs+lxlskNP4YjsMkFwmfONJyCS4="
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="completed keyexchange"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=debug msg="completed challenge"
Oct 29 23:20:37 volumio go-librespot[20457]: time="2025-10-29T23:20:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:40 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:40 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39.
Oct 29 23:20:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:41 volumio go-librespot[20464]: go-librespot daemon starting...
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="app state loaded"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=info msg="zeroconf server listening on port 46663"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="obtained new client token: AAAgy2pI07K13suVcYMzT6T+PIha2+UJjWmj+PPy0RbHAIkT7wN1OH0DdhOcQSXfMXR9ddy0jieydV/BDAOuqo6srkRi1fxHrbP4d56GIeujG42G6jp3fASm7h5tUhlmvzmBTdpFWZNA5cigIdqKaNiP0dZPHgUxyzKQ09KgqnUKnM/h+pTFuCW0dvDrTJIN9Rd90lFCNG0aCDbbhzyEtqbdNkJnfvHvRrmGHye/NyOzhMJ8zM5G"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="completed keyexchange"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=debug msg="completed challenge"
Oct 29 23:20:41 volumio go-librespot[20465]: time="2025-10-29T23:20:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:43 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:43 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40.
Oct 29 23:20:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:44 volumio go-librespot[20486]: go-librespot daemon starting...
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="app state loaded"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=info msg="zeroconf server listening on port 41101"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="obtained new client token: AABRZrvFESQOXpgUw5XPCfpJX+ghyZOt5z7fSTTFyrmj0h8OBDUpNDBfUo9wL3TXh3oyK/JXGixWZ2FJIRE3wfFaZoeOgGIUSjud+4zadvGP5kZuuojkU82NOss7JZcc6qulkwAXwD8zq08DNL1VyHMkA3ycnCPPVLeqDCvUvdXEZ5/3KGZ58gk5w/+JAmTU9CciG9r1dq1Ky6D+noaCg9qJeE6e4Jru+23o9x1PMw7dDUp/ueggcvg="
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="completed keyexchange"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=debug msg="completed challenge"
Oct 29 23:20:44 volumio go-librespot[20487]: time="2025-10-29T23:20:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:46 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:46 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41.
Oct 29 23:20:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:48 volumio go-librespot[20495]: go-librespot daemon starting...
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="app state loaded"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=info msg="zeroconf server listening on port 34125"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="obtained new client token: AAD+QE+khVkr7CtngDCD+BmdKqvTxP8H5hcUIhmPtJzU01a3p/yu+mmLC2q5bmQmSDLEsnntJYyTnrULhobUcbmWD8ouLa5TrsBFVPXU46svr6yzGBE4gr0kFGKF5MAYCwBocNUEkMaD9y53hK5ZsyN9GM5OJoulJ6biYZJhxA7LP2/F4biU1Aj/cE/61hVV3M7gY5ytEMDYOQm+XUjjmSoRjhPP9d1t1/dk8xOG0TMS1xVYZUt6"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="completed keyexchange"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=debug msg="completed challenge"
Oct 29 23:20:48 volumio go-librespot[20496]: time="2025-10-29T23:20:48Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:49 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:49 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42.
Oct 29 23:20:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:51 volumio go-librespot[20507]: go-librespot daemon starting...
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="app state loaded"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=info msg="zeroconf server listening on port 36307"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="obtained new client token: AACpy7SlyCrSvdLGvyy0zVj/AASK5RAvBdWNulCFD+NDaAeQDIEwdh7P9u5WMOCwo/6ywVHZitvQjt6ciPexV6KqD+gRPFHhNVrT6ArfX78hh2qA1f+SIA5yyAX6zAoL50I+ZPEnk30Fw/bJHeclRG7Far3aLDjtJazu9cBL/bGT3x7fGY5+M/eu+oct2Ylf/pw/XF/B1CtRaDXopdtFPLnBkYhIfTXBYejUGjWV7NsVjqGgPUELus8="
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="completed keyexchange"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=debug msg="completed challenge"
Oct 29 23:20:51 volumio go-librespot[20508]: time="2025-10-29T23:20:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:52 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:52 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43.
Oct 29 23:20:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:55 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:55 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:55 volumio go-librespot[20529]: go-librespot daemon starting...
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="app state loaded"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=info msg="zeroconf server listening on port 44263"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="obtained new client token: AADQeTr4BcLQae1PuvP/vURpltbtvFyYFfOBHbQzU8NuOf2V2UTEn5DPEjYi74ONig1QmJwtAIlDsp0SSfaHKog4guvuV//GWwjormGILe1AZw7g5lMD0oT0GPueoMmVzRDMFF/aw3L2Ii0bTH2GV6omT9ursYJIwbipe4iXqnm/2nQhJsPRfXxJaJglVvC94YQOlrfuHauBN66OwF3gBMr7TdW6pl5AkfaiOgNqeFsc7wnhA9pk"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="completed keyexchange"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=debug msg="completed challenge"
Oct 29 23:20:55 volumio go-librespot[20530]: time="2025-10-29T23:20:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:20:58 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:20:58 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:20:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 44.
Oct 29 23:20:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:20:58 volumio go-librespot[20538]: go-librespot daemon starting...
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="app state loaded"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=info msg="zeroconf server listening on port 33785"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="obtained new client token: AACKygigxRqW8k2t26mwNdrTVaMW9JhCY+ZBJIc55juBah1ayIJ4BzJOf7UznHRaNOjdyqam29T3vWxoHp0rlrcxsXS5Oq1jO9kM1iKTgKmMzfsl+zzxg1CPLbkK5nccA/dSqnG148JMvq1ahgpU8cu+TCSbbhpt5Bhg3VUuqynC62XAI9G+ErCouwM4A1d/qU66y1mNuAJSkWYti6lyWnN1X0I1eDQYPjfBaqZL2IDEISzzOEycXK0="
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="completed keyexchange"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=debug msg="completed challenge"
Oct 29 23:20:58 volumio go-librespot[20539]: time="2025-10-29T23:20:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:20:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:20:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:01 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:01 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 45.
Oct 29 23:21:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:02 volumio go-librespot[20546]: go-librespot daemon starting...
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="app state loaded"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=info msg="zeroconf server listening on port 35375"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="obtained new client token: AAACgl4aChUJZDPVm2jNriKfnQj+f8Hf0PH1JU0hi13kC2Apv0ySxFtqwgp8wFjZbbGi6dzwcN5EBB2VJJZkPbZdAdk5eQQ0221reIA9XsEC9R8zCOpiCxxuh1eQVqbNJTq/JxvZPgQf90dJFlrLt3fiEa5Ltwh72cVQe0YoqfPyqUkHOzruOIsBZ9AnD4jJrC6OLcTApO1kS79J6TibHhXtIsUqvbxvISSzuGZH0KnisF5WemgW"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="completed keyexchange"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=debug msg="completed challenge"
Oct 29 23:21:02 volumio go-librespot[20547]: time="2025-10-29T23:21:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:04 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:04 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 46.
Oct 29 23:21:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:05 volumio go-librespot[20569]: go-librespot daemon starting...
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="app state loaded"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=info msg="zeroconf server listening on port 38713"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="obtained new client token: AAA7DIQlbLQMCPn6S1Hqch9+2PwbqQLudet2LZSUHk1WX5ahqVXlhzfekJ5Ci0V2BU9HYG1X3OyT6ew8xvdstJe8whcGvNq6Epaxvy0yWCx90V4t4a53+mGZq46pa7MEa24ETmAMQBEqzElKYsFUilj1+H1eBjr84ORsPrggrJRJ02TaYbTK30KjJiF8mGcJtOhlsVQiH5Rh5d0cqOK1fOPmRZQw4SpE81jdSJBeyUwgrCREDjjwFDA="
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="completed keyexchange"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=debug msg="completed challenge"
Oct 29 23:21:05 volumio go-librespot[20570]: time="2025-10-29T23:21:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:07 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:07 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 47.
Oct 29 23:21:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:09 volumio go-librespot[20580]: go-librespot daemon starting...
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="app state loaded"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=info msg="zeroconf server listening on port 44245"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="obtained new client token: AABQEZyxbtq2IyKm7VsrEDZ96usqaTjTomZotk7RRlvcbtBUXlTnT9IiKo5NSz53OdjpFCo2oUpdWFoSlGgylXnQfs7QfnWDRo0VMX+2BpTmC7tWA15dH59h6PoPaTvJ6OoStscDjz93ZKnNKw7QP2JMqYKfVy8aD43bXC1KlFvLun59xQHzY7asKT7hGFsKWoAGu/6PcZiUeM5o8NCbEQqDNF950rDNcL74LQab1KpfxTCU0wPt"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="completed keyexchange"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=debug msg="completed challenge"
Oct 29 23:21:09 volumio go-librespot[20581]: time="2025-10-29T23:21:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:10 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:10 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 48.
Oct 29 23:21:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:12 volumio go-librespot[20588]: go-librespot daemon starting...
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="app state loaded"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=info msg="zeroconf server listening on port 36663"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="obtained new client token: AADLPqsiW0/T5JEcEmJUvh3ytEAff++w/34YE9mkwNIXxzbRNHOMxIITEu3ZWlpYfd0N2q67/3w+I1zKKg423dIDKk66LrMtI57DqnEDGrFxFZDzMO3jQhObfEXHxCD8zhwaYPSVvai0Dtmn7nKyEEXrBL0UmdEk8ke5h9+zb6ARixhl5zr9Zm9mQ+bq2n8mGRhDne7IJUBQSZPylZraSoifOaxWPThTIxFfs0YxdBkf3Jr4bbTacXo="
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" 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 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="connected to ap-gew1.spotify.com:443"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="completed keyexchange"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=debug msg="completed challenge"
Oct 29 23:21:12 volumio go-librespot[20589]: time="2025-10-29T23:21:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:13 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:13 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 49.
Oct 29 23:21:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:16 volumio go-librespot[20610]: go-librespot daemon starting...
Oct 29 23:21:16 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:16 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="app state loaded"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=info msg="zeroconf server listening on port 33217"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="obtained new client token: AADF78EeHB3qoe3c2MCA43X4fG8b7KK8GBGwIQKACcjq/LaHv+o8LngeO/VYWsbappZWhCLHvrXiRzuJ7HOIEd/5MFDpaxXldSCZZNK+fRua8fHlIFJ8gvzMQbnzsRclZzzpwM410T7smCBq3e03fZ9NSWyxg3sCyRjXpTVWLUIkUFyDx978vY3vp8n6VZQJixIfSkV7ANlyJW6Ep3CIKqxfHJB0WMKqB0XLq/fMldF95RKqgKyv"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="completed keyexchange"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=debug msg="completed challenge"
Oct 29 23:21:16 volumio go-librespot[20611]: time="2025-10-29T23:21:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:19 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:19 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 50.
Oct 29 23:21:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:19 volumio go-librespot[20619]: go-librespot daemon starting...
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="app state loaded"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=info msg="zeroconf server listening on port 36607"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="obtained new client token: AAABf3cGFUas5HTl7azz3s8KccFHa9JbGOTSHziWIsksx8j6X8O9PeribI8ZEMITny5UAPqpdVzl1d6CpYkHdwJYdnUyhO4VFqJCaVbJ83DiHjCBKIzGLUIIvuzvJJrtX/QxdiEtRzwgWONmBiWFwtlsAyXq9uBrt7IH9bccNaekR5OAy7fbUN8t6Rv93PfdnOd/4qa94Wnri14AckNpCLVSVqdfrwKyKcHpSrhDbNhb8J1fFtAezn8="
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="completed keyexchange"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=debug msg="completed challenge"
Oct 29 23:21:19 volumio go-librespot[20620]: time="2025-10-29T23:21:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:22 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:22 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51.
Oct 29 23:21:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:23 volumio go-librespot[20641]: go-librespot daemon starting...
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="app state loaded"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=info msg="zeroconf server listening on port 34549"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="obtained new client token: AAByP/XRGRAYbd1x+yjexxO472IHpqx5/hfQwHErAgQxUU3aw6Q2yCGiqUWSdTYmFRYUHC6WjJ5VzYB4c7D7PQdT9+djyhlwuE96lmZ0W+bdP7Fp9ss4INxzabRlAs8Wxi/8ILY+XMhRUoAwMqbwpFKAGI1JYro8rH4TpB21r20LuKe/j005Cfoz9BtQz6jmenhFHPRWNvSBh9NtcqseUpmNt2iad/NVAQ0HATRBGXzJ3xNtCqpQ"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="connected to ap-gew1.spotify.com:443"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="completed keyexchange"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=debug msg="completed challenge"
Oct 29 23:21:23 volumio go-librespot[20642]: time="2025-10-29T23:21:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:25 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:25 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52.
Oct 29 23:21:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:26 volumio go-librespot[20649]: go-librespot daemon starting...
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="app state loaded"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=info msg="zeroconf server listening on port 45163"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="obtained new client token: AAD0XAO1gAdehEAx93lk+e4x5ocVsMApzeHNQAETwhC41XVYuKGjPdDMIiilLMUoZOHVpF7Qi0Y7EoBoGWz9cHskM6QyaV/IqJ7HaJwVYEeBui1LCfoqw5MlE6ZIL9Ap1DJ2lUidPKb/SUx3kiCSrJoKw874Ew/pUIJCIdzJWWuOsI/YDV4tYLqs3qjm/TfeYfF2wFlRLAXyZME6E9oJDlD5XBHB9l7z0VSccP1FiPkw0zakKOzGxQM="
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="completed keyexchange"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=debug msg="completed challenge"
Oct 29 23:21:26 volumio go-librespot[20650]: time="2025-10-29T23:21:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:28 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:28 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53.
Oct 29 23:21:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:30 volumio go-librespot[20660]: go-librespot daemon starting...
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="app state loaded"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=info msg="zeroconf server listening on port 45077"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="obtained new client token: AACs5/h0JSS6pzckOMuShMwFxifa4hNLxVlppKj3P5p2d9h9AtvZwIVgs1+TBaNmdOq9mf6N62VimozqZmo64c/TKqfdBGsBTGWWZtwzDk8MpkdTQxic2tkSkVjV79TQBJ+P39p1H4GQFSskAL306l1TrdoXaFtSE0ozD+Nr8E6QKLj2rdGhC2ugRfoEU1jlWKMxUNutcp4kB+yIPKUXc1KZsxhxiIKRv9lbs1puy3vQWeoDK6t1"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="completed keyexchange"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=debug msg="completed challenge"
Oct 29 23:21:30 volumio go-librespot[20661]: time="2025-10-29T23:21:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:31 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:31 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54.
Oct 29 23:21:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:33 volumio go-librespot[20682]: go-librespot daemon starting...
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="app state loaded"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=info msg="zeroconf server listening on port 33913"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="obtained new client token: AAAnCMzmSfGt5IvJ4qXOBxGODAGaAH7r4ldfN3nqJ09hoimyfNvecv/KLoTbeQMKIOctjqbLljoYigvy1xCXAoQmsZ44p8+Yaax2BMMnYeo8UNQC7VlPShAQKbi5pbB6qKdxJWsVDMJi69Q4+kBRgBOj+FJ7M2nSxaDb/hUY8gj8z+BawFBEvGKENZwyCjvzOFbURym7LT5gdUOKOANDhGNM50bmJYv97Pk5O1AU8BBlOme+DxVXrXI="
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="completed keyexchange"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=debug msg="completed challenge"
Oct 29 23:21:33 volumio go-librespot[20683]: time="2025-10-29T23:21:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:34 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:34 volumio volumio[19603]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55.
Oct 29 23:21:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 29 23:21:37 volumio go-librespot[20690]: go-librespot daemon starting...
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=info msg="running go-librespot 0.4.0"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="app state loaded"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 29 23:21:37 volumio volumio[19603]: info: Initializing connection to go-librespot Websocket
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="new websocket client"
Oct 29 23:21:37 volumio volumio[19603]: info: Connection to go-librespot Websocket established
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=info msg="zeroconf server listening on port 39297"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="obtained new client token: AAD8suXDeYTiNIiy6PegW4xVGKC3PvFtFQ/M9yfieQPvf7ktsa/4TQAKFHSvQaDkPpEz8gFIMP3IKM32Rkb0CGD4jvVQwN9QFddp+v1Z3L98H3IcZCRmJkLrQ6XvumLBTF5BWxCALW7FRNHeg3f+WRHdJmejQwh4J4xz46XNKx/XmdqtSOZbeKPZBms//cye4RMN7Hpi/ayr57a9FHkBX472auETGBF8kByTa9OYUYafP1tb6dSk"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="completed keyexchange"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=debug msg="completed challenge"
Oct 29 23:21:37 volumio go-librespot[20691]: time="2025-10-29T23:21:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 29 23:21:37 volumio volumio[19603]: info: Connection to go-librespot Websocket closed
Oct 29 23:21:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 29 23:21:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 29 23:21:40 volumio volumio[19603]: info: Getting Spotify volume
Oct 29 23:21:40 volumio volumio[19603]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 29 23:21:40 volumio volumio[19603]: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 29 23:21:40 volumio volumio[19603]:     at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Oct 29 23:21:40 volumio volumio[19603]:   errno: -111,
Oct 29 23:21:40 volumio volumio[19603]:   code: 'ECONNREFUSED',
Oct 29 23:21:40 volumio volumio[19603]:   syscall: 'connect',
Oct 29 23:21:40 volumio volumio[19603]:   address: '127.0.0.1',
Oct 29 23:21:40 volumio volumio[19603]:   port: 9879,
Oct 29 23:21:40 volumio volumio[19603]:   response: undefined
Oct 29 23:21:40 volumio volumio[19603]: }
Oct 29 23:21:40 volumio volumio[19603]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 29 23:21:40 volumio sudo[20713]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-29 23:20'
Oct 29 23:21:40 volumio sudo[20713]: 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"