Oct 29 11:17:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Oct 29 11:17:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:01 volumio go-librespot[21285]: go-librespot daemon starting... Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=debug msg="app state loaded" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" 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 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" 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 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" 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 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=info msg="zeroconf server listening on port 38921" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=debug msg="obtained new client token: AADzfp8oLUy2ottpWt9AVjfPIT4QFz9y6XP3ZsWIDUuK4nuMgDBlOmFINs6WTpW/Uyg66N9Nw306G+NDk74DIg0FLa5ffzveqZt0kSnxXKQybvH1kTTnhwVmsJJduI22DdzC3fsqsSQ0H9Xk9Y+zFOuqhwmFzLjdWECFBHS9s4BCp0BAl0gTwlWkZtWeHsc2YC6C3s4XsXiOqUn5e/PLlxkgT6IedTs21xaaDq3vton7mUBpU5T1" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=debug msg="completed keyexchange" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=debug msg="completed challenge" Oct 29 11:17:01 volumio go-librespot[21286]: time="2025-10-29T11:17:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:02 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:02 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Oct 29 11:17:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:04 volumio go-librespot[21293]: go-librespot daemon starting... Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="app state loaded" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=info msg="zeroconf server listening on port 44223" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="obtained new client token: AACsSy7LKO+1rIXxaidgI2phSTS00xk69JLFz//NQotIv2luSVv4P6Wz81FTsJjViY3Dpxs9cdju0GRgqike1MNXOccAyt5vE5asx1uuJEu+oy5QP9ytBRjnoriTWyLHwC4gwd6FyOtshmL/L9LEZl9EdGTlms3LgWYBE+zW/aU7l8U1e4JFnVuLKrI86vXkoZrPnJFTcBwNsqpfZNg5QrDXmIH7PJ2p53sP+zLMNtjviNoyJqsDuWA=" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="completed keyexchange" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=debug msg="completed challenge" Oct 29 11:17:04 volumio go-librespot[21294]: time="2025-10-29T11:17:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:05 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:05 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Oct 29 11:17:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:08 volumio go-librespot[21315]: go-librespot daemon starting... Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="app state loaded" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=info msg="zeroconf server listening on port 45925" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="obtained new client token: AABHnvGzi41pS8YYa8BoEbG+Ipp0XSiyJZttRJ6svLg1X3BM3gagN2qyLAvWiMEgcvnr6arc0O7e9TFhIbhQz7Tkm6LHRuweGgMjuHVu4AdMwlaElF0a14Kq/EklVlznv2+zDze3utDf7Or9Al4HSDKBFrAcajavwlDMBL38JBCqZ1ERHtKV4TLxe48thnyRTogDb64Wgbgb8F4uSCkPDlHAaqQUFIDg25djfPfi7HXY6n64CwoI" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="completed keyexchange" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=debug msg="completed challenge" Oct 29 11:17:08 volumio go-librespot[21316]: time="2025-10-29T11:17:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:08 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:08 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Oct 29 11:17:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:11 volumio go-librespot[21323]: go-librespot daemon starting... Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="app state loaded" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" 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 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" 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 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=info msg="zeroconf server listening on port 40065" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="obtained new client token: AABH+gox2Of2f/hWFaFXBuLsnCWy4OBJTdGzIrNZHJ65K33roGrsBBFxJ0Kuh7OyvAQzCqvxpLiT1A1CcPk9WsYVmSVt7KPxUjE2+fntvQEGPaqmmg2v9Jh1l8r98X1WtPpvWJUvouhmu4dzwqUBJizoBjxzHN0iu8mdHxPhjmetlNn+S1VA2UPbAb5uBbvLt32qsqIyDnmflHrjdIjGYFuq4ec7lzPcGouz5dyGVlFY9Z8Vz4izL3g=" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="completed keyexchange" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=debug msg="completed challenge" Oct 29 11:17:11 volumio go-librespot[21324]: time="2025-10-29T11:17:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:11 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:11 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:14 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:14 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Oct 29 11:17:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:15 volumio go-librespot[21334]: go-librespot daemon starting... Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="app state loaded" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" 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 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" 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 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=info msg="zeroconf server listening on port 38865" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="obtained new client token: AACVDA8W6i1tcGa3S5iLHaoBu5qNH6Hkse5ld3jAtqQVDCQSueEe3VJQvxeD/RMkT5slZ4VO6vg7CZIrXn8GOgM6x6nmsmcjU0HwQAq5w4JQkpo5V9OueMIOrqeJuyFb2Eq93rPu3qScS7Kx8yrayVKf3H+/8Ek4i5Dgs4eve0I/HqcT5euw17JpkFCutPJ5ghgHitGORBR3fWPkXpqUWXPlcfyaeUsRJZ+O5AvvCaaa3UAci17M" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="completed keyexchange" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=debug msg="completed challenge" Oct 29 11:17:15 volumio go-librespot[21335]: time="2025-10-29T11:17:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:17 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:17 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Oct 29 11:17:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:18 volumio go-librespot[21357]: go-librespot daemon starting... Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=debug msg="app state loaded" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" 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 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" 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 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" 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 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=info msg="zeroconf server listening on port 35049" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=debug msg="obtained new client token: AABLMQSgcr8qNq6ytJpcawhL53hNHUjcP+vdJZ6FZ0+EurcDe7mHXSDLPfpHr715DNv0ouYLdsvtaGSKLaWr47hrm7tV2Sp434i07tpRlSgXsUvBD7+c3/vUJhx1NxZz0hBMZsDkZQZTtXaWvo1OBayuSFsIuUtZR13HAWRjf0rcTxMpgKnjG2JmWhmdOd+s2drwHiABE3p6/enYC3f7UfwQ5AbrgEvtQYagvKiH9Nwc47L7SUBtjkY=" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=debug msg="completed keyexchange" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=debug msg="completed challenge" Oct 29 11:17:18 volumio go-librespot[21358]: time="2025-10-29T11:17:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:20 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:20 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Oct 29 11:17:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:22 volumio go-librespot[21365]: go-librespot daemon starting... Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="app state loaded" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=info msg="zeroconf server listening on port 45587" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="obtained new client token: AAAbcnnqijPBGSZmOD2eSwHlETyRiWrvB7gXxG9igni9q/vyDWqYX5+uxrXSDdV8fJ3gabCl4ezr0MySN5pdK2yn31LNWg1W8nP1dxB1O1ChWS4rHBZHClAdF0NivSpGn9quk7oUvSC+p7sQeETRvGHZv9/5Lf5rJex3x4K9UpV9J/LFJSzsneh+Gew+n/jDYT56b5OjzIZPbr27UtUXAErTN2EscW8/pE10Mu5tBcAhVRl8bjLb" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="completed keyexchange" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=debug msg="completed challenge" Oct 29 11:17:22 volumio go-librespot[21366]: time="2025-10-29T11:17:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:23 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:23 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Oct 29 11:17:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:25 volumio go-librespot[21374]: go-librespot daemon starting... Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=debug msg="app state loaded" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" 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 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" 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 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" 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 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=info msg="zeroconf server listening on port 33987" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=debug msg="obtained new client token: AADAwUJtgo/+rfzDiVETlA4HsuYqVvrnE/AZOBUlZqOAhFCkl4NeJxPblnonOtVRl9pVUJFiMcsYLpt8Zr2qjrw2IwXXUqgeaa08kThzt3w3DA1aVlQBf4Qks9AGasxLMDebxt3YmTTdmXX16j+FAIWIkxxAM6Ou7Dt49XjUAOfb4JW7S6A/08PI9KOgDCC+VB6Lhrb62P0JzpQlp1zyQovveLUHuyvXS6owXyoBc40DQ++JqwCIrKk=" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=debug msg="completed keyexchange" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=debug msg="completed challenge" Oct 29 11:17:25 volumio go-librespot[21375]: time="2025-10-29T11:17:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:26 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:26 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Oct 29 11:17:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:29 volumio go-librespot[21397]: go-librespot daemon starting... Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="app state loaded" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=info msg="zeroconf server listening on port 44837" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="obtained new client token: AACOp/yORdrRs85qpIL8+Vy9h87xqKJetN/FAlQ/6Julkc9TGSloQfWWWQChV0CIEeF4Qfc4VpLMR1HMoZIvC0KMK/lqEKGebNqsXHxurcWugXghhDib9zHgdjxD5GFFp6ZIrgkarbRmrXU1Y7nOYoKFSzDNI8Pa5A3lOGrjpVfiCXBj0xKeZNnjCJaDx2WYwgLVXJOkRJcLKNpyA+2IHKUQrAMsyNZ3WjI3pHIEeFogJOXswaQD" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="completed keyexchange" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=debug msg="completed challenge" Oct 29 11:17:29 volumio go-librespot[21398]: time="2025-10-29T11:17:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:29 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:29 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Oct 29 11:17:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:32 volumio go-librespot[21408]: go-librespot daemon starting... Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=debug msg="app state loaded" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17: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 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17: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 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17: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 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=info msg="zeroconf server listening on port 45709" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=debug msg="obtained new client token: AAAPmllBu8hUB9R9IcFSB591QvBsbCMZcnwLpBZqHwD8a17N5f4ioa/tTPpcbnJkb/UI0OH4ZlSu51ZuFYIRTtUVwMMWmoTIdBUjo+gZsk2Ic8I7PuYoBYkT3mPHVvD6kfn3zz7hWIejyFU/uCVErKULaaxU6uWN6PVqdLyyLVI0d0REs/Jei5ALsiakaC7YB/cwFJcIrCnBpaly9N2q3w8OL5nlMOwAeCFYAuEkSKnNv0i4KVyD4P4=" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=debug msg="completed keyexchange" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17:32Z" level=debug msg="completed challenge" Oct 29 11:17:32 volumio go-librespot[21409]: time="2025-10-29T11:17: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 29 11:17:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:32 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:32 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:35 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:35 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Oct 29 11:17:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:36 volumio go-librespot[21416]: go-librespot daemon starting... Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="app state loaded" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" 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 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" 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 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=info msg="zeroconf server listening on port 41353" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="obtained new client token: AADgL0LOKOtZtTFccmO4bF0npf1VFILLNTy3nHArUbqYtDCpEpK4r8AIwOzOkNhK1GxY8Swjw5B7b/dtotQePXwrQmPcw1mETFWqt1Bi0ZIkBGYdgNGn0JrxkzVXV5DFAmR1JkOcA4ktdilfd0mBzXddirAAKddiWVMm+cHYSFdbOIZSdICFNxRQlvauTSbwxlu43qx5Z7pg+eXslTdYGim4PsXUKK46vUhQiq59fmCV25F19GoR" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="completed keyexchange" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=debug msg="completed challenge" Oct 29 11:17:36 volumio go-librespot[21417]: time="2025-10-29T11:17:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:38 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:38 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Oct 29 11:17:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:39 volumio go-librespot[21439]: go-librespot daemon starting... Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=debug msg="app state loaded" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17: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-gew4.spotify.com:80]" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" 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 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" 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 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=info msg="zeroconf server listening on port 39363" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=debug msg="obtained new client token: AAAy41noosoTTJVdS53DooFqvHDiW69Tzexs1SIS/MwI+nimxPBuJj1ErGZJonak8+HUTM0eHAbME7gkwTKO0Qh9zVL7lj+n9IwWnus2407GOpPbjcsF6uVHJ+z8sl/51tVBazGbFzhuwPYhpIkyj7iR0m+PhUg/Y3YyYMbf6cNG2W/iYhdmmrdXtRjPmFhh2n5t/WPRCUfiwFGKyF4JsdqPEul2MdYs9YD8j5vP8sAqzMuVD9eOC3w=" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" 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 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=debug msg="completed keyexchange" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17:39Z" level=debug msg="completed challenge" Oct 29 11:17:39 volumio go-librespot[21440]: time="2025-10-29T11:17: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 29 11:17:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:41 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:41 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Oct 29 11:17:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:43 volumio go-librespot[21448]: go-librespot daemon starting... Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="app state loaded" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=info msg="zeroconf server listening on port 45325" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="obtained new client token: AADyIh10EWeeHtcWDIRUFCnQA5nwxaF18AZDxUTWUC4nWLZgxcudbwmMfRQIQnBUSMndfPYmGoc5UbDwQE7QPIcCXINiZnfUGTM4a5iblCq8sQPb20ITeL2JG0mjNQVqb4HIzGddxo0+gT/na3EzBhSulxOgumth8rwLENsqjVaWE2Se9Fu8eaGbaoJdjcT2yzkJF3vrs/DCnu+lHtwozD9QYiawVgH9szKNQomOM42Lxd34fzwY" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="completed keyexchange" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=debug msg="completed challenge" Oct 29 11:17:43 volumio go-librespot[21449]: time="2025-10-29T11:17:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:44 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:44 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Oct 29 11:17:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:46 volumio go-librespot[21470]: go-librespot daemon starting... Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=debug msg="app state loaded" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17: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 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17: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 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17: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 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=info msg="zeroconf server listening on port 45571" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=debug msg="obtained new client token: AAAqsPuXoXK85rOxLm58/qfehwG+PJJ89E3pWawy20/aKaZPl/Ij6UZ3AEKuFPjUziLbMw7PznQ3vGB5YPC5pMTWS04wPmWxSpbHGxCWLrHJFdmK/mnesBVEFKdvElMTIyCg8GWidiyJ84UteMoZhf4tkL6wgiBsm7MQzCPnc1Mlq9tyljv9SWp7tOB9F62GPniGRw3hCcAinUtGhzzqDlXwCq+adtkfGh0z/U4qKkGS3oebPbsWzO8=" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=debug msg="completed keyexchange" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17:46Z" level=debug msg="completed challenge" Oct 29 11:17:46 volumio go-librespot[21471]: time="2025-10-29T11:17: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 29 11:17:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:47 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:47 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Oct 29 11:17:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:50 volumio go-librespot[21478]: go-librespot daemon starting... Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="app state loaded" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" 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 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" 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 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=info msg="zeroconf server listening on port 43789" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="obtained new client token: AAD5z79WYofLlKTT7Lafv+3gmFxhH6BLdLMKKfDTlVaFhLZxi/FwccMqFgA9GrtFPznsZTpkMqDU4MRudcG65Zsx7e0zEhl1A94xtJ+EXrACvupunoMpsdJfwqyqkBJYSMbgMftZ91D5cEnqGNjwizCs/iLxCtRtWZheWL36Wszh2c6O5hIAPm2WGjMYlJkvSY1/dIoD6PThv+81OvK+S2qpbrU9vjwzAbeDz9/GmryLTiVD+G+n" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="completed keyexchange" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=debug msg="completed challenge" Oct 29 11:17:50 volumio go-librespot[21479]: time="2025-10-29T11:17:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:50 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:50 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Oct 29 11:17:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:53 volumio go-librespot[21489]: go-librespot daemon starting... Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=debug msg="app state loaded" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" 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 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" 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 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=info msg="zeroconf server listening on port 34659" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=debug msg="obtained new client token: AAC3GVOINkt2XGosONpEYngjWjQgeHJWv+bytjh80RAqDGzohdJIC1XA9wKBnd4uohTsm5Eydsc+K+cJJlFC1viV0/QHIosnYJN9BT54IAfLXzneUh0irHkEHiVgpiZ4VqxCKW07HdIWl/Sxle0yX3FuxJahQvbu4JH5FPXlyeRql64UI3PkeyEFwOckaw8Mwe0KXb6qcz9BGsmrCuQLWks1NC1d4Lw0z2bJ5jFQhz19e2kkCnmPZv8=" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=debug msg="completed keyexchange" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17:53Z" level=debug msg="completed challenge" Oct 29 11:17:53 volumio go-librespot[21490]: time="2025-10-29T11:17: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 29 11:17:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:53 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:53 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:56 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:56 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:17:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Oct 29 11:17:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:17:57 volumio go-librespot[21511]: go-librespot daemon starting... Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=debug msg="app state loaded" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" 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 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" 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 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" 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 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=info msg="zeroconf server listening on port 39847" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=debug msg="obtained new client token: AAAnR/v9DHz9oUya+IpwocB8r07HOdzGUU1IIbKFONLx1mbiy2Jaw1CmaC4Ie76RgNPvb1WKDBUdlpd7MAMNtqLE7OvcTFiUmoZJ8iAOkeQqdjtu+2BZRYWtjEIa4coWX2Fmp0qND7CIbxVkDVoqJnPtiWstfiuqJLun3iYsrTibP347zkWHB5NODOQSCbgACPms6CaLRFXo0i/7j0NM9iXLldKq9tBOrQow9VFK/nUA59eg13+Y" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=debug msg="completed keyexchange" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=debug msg="completed challenge" Oct 29 11:17:57 volumio go-librespot[21512]: time="2025-10-29T11:17:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:17:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:17:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:17:59 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:17:59 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Oct 29 11:18:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:00 volumio go-librespot[21520]: go-librespot daemon starting... Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=debug msg="app state loaded" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" 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 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" 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 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=info msg="zeroconf server listening on port 37295" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=debug msg="obtained new client token: AADJSzetEsZQa81h5S6QooIP7khhwAD7XvcgwMZxMBcAY0zTfivIPheQ0CmJ7RggdFyYUcyQlOLlmXa2FS+OCh4uQMKxuoyXEm8CTqZmbJ76OhhoTdeSeZXL0X+Ad0f23UzuKy43TIk6fRx3DaXdMeXFc5gwoNE30Cd8NxDr6G49CE9CdAbwZxLiRnKR/HbkwvNbQkLI8S3bemQUtjJTUrxZ2470G4eD2YNzJ/s/ulDFfkLsyvnqBhk=" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=debug msg="completed keyexchange" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18:00Z" level=debug msg="completed challenge" Oct 29 11:18:00 volumio go-librespot[21521]: time="2025-10-29T11:18: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 29 11:18:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:02 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:02 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Oct 29 11:18:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:04 volumio go-librespot[21528]: go-librespot daemon starting... Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="app state loaded" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" 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 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" 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 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=info msg="zeroconf server listening on port 34795" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="obtained new client token: AABuBXBWGDNCNfeANZhytMJUsMzSjpR70z152RVhuTQZyJiGlVKLvpl3aZtRBksClbNUz10yc06LS2/iXG22fpkCHiLUsiz9hrpOB6sxPpYQQF31bXnKvUq+/YRqGxmHY6U9RekCQnWMw2FCBdul6ZbF5Z5n05bGWUUpj45sIBgA3sIIP/g2O9B3CmgtXWVfAA/fl4jeYoCbrDyNNBjamKUjgepcAuzNWEz57h1waYRnbwcYPx1e" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="completed keyexchange" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=debug msg="completed challenge" Oct 29 11:18:04 volumio go-librespot[21529]: time="2025-10-29T11:18:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:18:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:05 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:05 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Oct 29 11:18:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:07 volumio go-librespot[21550]: go-librespot daemon starting... Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=debug msg="app state loaded" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" 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 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" 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 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" 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 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=info msg="zeroconf server listening on port 34717" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=debug msg="obtained new client token: AAAnEil9IQv0dN0ApYO+4yLwbDlGx1zrW4xlu0YvhpuEyA7Xdcf9RrwbSbo5QtBI2NKm+9cYvGPRVVXV+bHwdT0ScJ85o/fyLpDijYdoYyfLxeEaAki2gdGAEbei3uPBDByseKpeobuoFft4y+FMHIDNhqoC3ZGf6b32UWJyOPdT0sfSwi4YvAT/I8jHBA0/c9GQkdRCdH++iHgEliwD0LFxpVrO81dPIIpCZ7jPhT9Zud+f7p240DY=" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=debug msg="completed keyexchange" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18:07Z" level=debug msg="completed challenge" Oct 29 11:18:07 volumio go-librespot[21551]: time="2025-10-29T11:18: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 29 11:18:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:08 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:08 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Oct 29 11:18:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:11 volumio go-librespot[21558]: go-librespot daemon starting... Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="app state loaded" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" 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 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" 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 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=info msg="zeroconf server listening on port 38911" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="obtained new client token: AAAP8Ib895qgu1H48zKkVI1JkLzn0+j20icb4kGOr+INJZ86RUR2kpN7+h2De4ctcq/52JXzeisQkYDF6cUt2oBqvVkq+JiIRc+XMRN8AdLwbjIyCTbfYgpQclAl1jhxLtMXqz0gbyoICAfEgkKsJYEZNz1+JxrdQ7+rDLnb+quavj2nAcQ1Pf3++Pc5BkSPeJHhaLy5E3ZOCs9Mq9aF2eiCvvnnQ8ZouJXrA7Uk2BwMZI25br8o" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="completed keyexchange" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=debug msg="completed challenge" Oct 29 11:18:11 volumio go-librespot[21559]: time="2025-10-29T11:18:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:18:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:11 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:11 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Oct 29 11:18:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:14 volumio go-librespot[21569]: go-librespot daemon starting... Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=debug msg="app state loaded" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18: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 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18: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 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18: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 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=info msg="zeroconf server listening on port 40667" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=debug msg="obtained new client token: AADk7IlIvLpliGK6+LJLATGQ1uocpH6O42tcYR9r8deWvudDfGhP1u2uyv9+2F4yOa0ov4L+K4S32Gb8BKlUKpyXfW5LX4VN6eZoQ2K4i8GgNZXGjXPu9TyT76rqhkIhzbAFBk4mPazoBQmsSQ73wUMPysiqry3RLXzmFgMXpu9tSOlZ1oq9Uv/McOEBUULng9JTH5lQ7dctrTTFEoi0KCgrzDWUiX5jsSfoBbTOUWSwAN/z66/jCsw=" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=debug msg="completed keyexchange" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18:14Z" level=debug msg="completed challenge" Oct 29 11:18:14 volumio go-librespot[21570]: time="2025-10-29T11:18: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 29 11:18:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:14 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:14 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:17 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:17 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Oct 29 11:18:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:17 volumio go-librespot[21592]: go-librespot daemon starting... Oct 29 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" level=debug msg="app state loaded" Oct 29 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" 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 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" 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 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" 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 11:18:17 volumio go-librespot[21593]: time="2025-10-29T11:18:17Z" level=info msg="zeroconf server listening on port 41655" Oct 29 11:18:18 volumio go-librespot[21593]: time="2025-10-29T11:18:18Z" level=debug msg="obtained new client token: AACEcI4Ov6ZyaP/2UFHuUil+bI1YQIkESswEGo8qcwo3RUzFAQ5Vlpdv/1ueoNaF3qfzF/b4L8HNriu4/XaTOGkzCEDpXJTOuJmcuZl3i4lrTjL9N3AFDGtyo5ebZA5h9ZIWPAWyRP2nJR5jQDPy1EXvwI/eyxZ4DLReMmKIYBY8m6GcYr8toIrRBjToYvbv7hqD4zBBh7SP1rE1aFvm+mveGwXoQSUqE/S/KPtyF+c011BkppSN" Oct 29 11:18:18 volumio go-librespot[21593]: time="2025-10-29T11:18:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:18 volumio go-librespot[21593]: time="2025-10-29T11:18:18Z" level=debug msg="completed keyexchange" Oct 29 11:18:18 volumio go-librespot[21593]: time="2025-10-29T11:18:18Z" level=debug msg="completed challenge" Oct 29 11:18:18 volumio go-librespot[21593]: time="2025-10-29T11:18:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:18:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:20 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:20 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Oct 29 11:18:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:21 volumio go-librespot[21600]: go-librespot daemon starting... Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=debug msg="app state loaded" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" 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 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" 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 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" 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 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=info msg="zeroconf server listening on port 32925" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=debug msg="obtained new client token: AAB0INHJV9Icc/aypvVb40V/FwSNFVgeluwVKx+IDlI+VxpbwdJ4uIRQy+D6X9gy7SpUPZaA41gRKxrxuAGFhpUBlhhbTdJ955SeLK6kyxsQtWhD8Q6njeRR42TdP2P33UwTquzOtBkkIM8wWiXU3Z1Aq8OREDP/xyiHr6xRdM4IFPQ0e219R2MWjvvu7imyYQ7E4tgdBDRzbDoRqCGCUL7+y/N1uwKDwF8BRaLEBan+g5oAWRuPXhs=" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=debug msg="completed keyexchange" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18:21Z" level=debug msg="completed challenge" Oct 29 11:18:21 volumio go-librespot[21601]: time="2025-10-29T11:18: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 29 11:18:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:23 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:23 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125. Oct 29 11:18:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:24 volumio go-librespot[21608]: go-librespot daemon starting... Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=debug msg="app state loaded" Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" 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 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" 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 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" 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 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=info msg="zeroconf server listening on port 42135" Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=debug msg="obtained new client token: AACyNMrtr1izTwIxbyQ+D7PIcEq7MrnpVII/PpdAAnJO5nFVqPxCOCneqO0yJUv9DFggYieoxR3/7jEL0Hw1I9tLNPL2qhpA7YP+/xgPO8SuBr3L/BMF0FLK8zeVZeY2bqWjDwiuRfOXCVSfLkJ8MjEPle54rcXkYHPiuSh7j3IsL9YCEtiTZBNu5M0dEEZ69CXVj/dmAFz7/b9ziUXNhVyT4tcIzJQ/y5dyvLCYrPbd3rE9wq5nNR8=" Oct 29 11:18:24 volumio go-librespot[21609]: time="2025-10-29T11:18:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:25 volumio go-librespot[21609]: time="2025-10-29T11:18:25Z" level=debug msg="completed keyexchange" Oct 29 11:18:25 volumio go-librespot[21609]: time="2025-10-29T11:18:25Z" level=debug msg="completed challenge" Oct 29 11:18:25 volumio go-librespot[21609]: time="2025-10-29T11:18:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 29 11:18:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:26 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:26 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 126. Oct 29 11:18:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:28 volumio go-librespot[21630]: go-librespot daemon starting... Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=debug msg="app state loaded" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18: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 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18: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 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18: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 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=info msg="zeroconf server listening on port 44011" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=debug msg="obtained new client token: AAC/BtX9lxjIiuUo+Uh15MJ2Srk177uMtz87ozwLdbWpscFjGo+cklXSRWe1bs0+2GEg43naWgIr7oXbyUTVo82vWBeFxtBtJ35loRCEuqCeZuNh6BRFJ3xxAbwFFhU1ahLFhk1VxC2q7G21KZ0sb8xsUcPoNP14S1oQ3lNhCJPYHrobp3mga4zyQA/4c6MsUR8FcQP1sbO7ONmSW2sid2ema4XhqdrLek3vzqoBZgp2D9mIL00pGtA=" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=debug msg="completed keyexchange" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18:28Z" level=debug msg="completed challenge" Oct 29 11:18:28 volumio go-librespot[21631]: time="2025-10-29T11:18: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 29 11:18:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:29 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:29 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 127. Oct 29 11:18:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:31 volumio go-librespot[21638]: go-librespot daemon starting... Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=debug msg="app state loaded" Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" 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 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" 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 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" 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 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=info msg="zeroconf server listening on port 34033" Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=debug msg="obtained new client token: AAAMBsMWIMiAWQV6sbBvbY1G/a/YNIzp4CPXoKt6af2IoP7BiHLFTd1BmbLOIyOT801SMWYAuRSy+zKay2Zd56xXbuSdlQHzqj+cD4Ku14StTV7sU67lejSiHnsF0V75en2jxxmKYmtUXMb4Op/nJZNoyymKJPw2dCUzqtFWhnoEwpMg1xpK2uEGqsSiVoI19QbM5dDGVGsAyJ2CKTN0ZwKAcmlNkQNjF9Tq0/90MIum85zHoGnJ4tk=" Oct 29 11:18:31 volumio go-librespot[21639]: time="2025-10-29T11:18:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:32 volumio go-librespot[21639]: time="2025-10-29T11:18:32Z" level=debug msg="completed keyexchange" Oct 29 11:18:32 volumio go-librespot[21639]: time="2025-10-29T11:18:32Z" level=debug msg="completed challenge" Oct 29 11:18:32 volumio go-librespot[21639]: time="2025-10-29T11:18: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 29 11:18:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:32 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:32 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 128. Oct 29 11:18:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:35 volumio go-librespot[21649]: go-librespot daemon starting... Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=debug msg="app state loaded" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" 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 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" 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 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" 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 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=info msg="zeroconf server listening on port 34475" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=debug msg="obtained new client token: AAAYree2vz4lSq6vF4sYWR3D4SnRBxXAum3Yx4uBI+PKzqQXaST+KC0Tyo4UawZ1GZXZwIDCw1EeCjPAbiJ84D+4z0ZYp1OBQVmYeoAJGzUUwQhVrNS2nFtvJDogwx/7OBTOpG268FjjK0yby4z40QN4vZJGxAzuqANe+wphLNyWWnOSl7bV4vEY1rSEcxfVBCtn2aK1ruG9BFRQlWDgqFrLIuLmK6SDTquYzKOH9cHovYoVO0IYAGg=" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=debug msg="completed keyexchange" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18:35Z" level=debug msg="completed challenge" Oct 29 11:18:35 volumio go-librespot[21650]: time="2025-10-29T11:18: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 29 11:18:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:35 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:35 volumio volumio[20777]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 129. Oct 29 11:18:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 29 11:18:38 volumio go-librespot[21672]: go-librespot daemon starting... Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=info msg="running go-librespot 0.4.0" Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=debug msg="app state loaded" Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 29 11:18:38 volumio volumio[20777]: info: Initializing connection to go-librespot Websocket Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=debug msg="new websocket client" Oct 29 11:18:38 volumio volumio[20777]: info: Connection to go-librespot Websocket established Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" 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 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" 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 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" 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 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=info msg="zeroconf server listening on port 44971" Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=debug msg="obtained new client token: AAA9JoKRrjvetZlW8b+dPYpeIOAbmwmkt5xac22cDjU2q2RpK2Jwv310dsVqkApzsqRtR0QocnCzyzGGkAJ7kbmMlALruVEsq3PXn6vqUR/jTL21sF+LA91TxfcjcYYfvpPHtuyHW8lAhtcb2zW3NCt9qr5nE3RitXrSBd6+OcZy3Yj7dqzHGHhF7M8FKrAQpquWEjDJOblM73Etzusn5TtYpdajquCfC97CCKfHZIi8rUJpTYZMWDs=" Oct 29 11:18:38 volumio go-librespot[21673]: time="2025-10-29T11:18:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 29 11:18:39 volumio go-librespot[21673]: time="2025-10-29T11:18:39Z" level=debug msg="completed keyexchange" Oct 29 11:18:39 volumio go-librespot[21673]: time="2025-10-29T11:18:39Z" level=debug msg="completed challenge" Oct 29 11:18:39 volumio go-librespot[21673]: time="2025-10-29T11:18: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 29 11:18:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 29 11:18:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 29 11:18:39 volumio volumio[20777]: info: Connection to go-librespot Websocket closed Oct 29 11:18:41 volumio volumio[20777]: info: Getting Spotify volume Oct 29 11:18:41 volumio volumio[20777]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 11:18:41 volumio volumio[20777]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 29 11:18:41 volumio volumio[20777]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 29 11:18:41 volumio volumio[20777]: errno: -111, Oct 29 11:18:41 volumio volumio[20777]: code: 'ECONNREFUSED', Oct 29 11:18:41 volumio volumio[20777]: syscall: 'connect', Oct 29 11:18:41 volumio volumio[20777]: address: '127.0.0.1', Oct 29 11:18:41 volumio volumio[20777]: port: 9879, Oct 29 11:18:41 volumio volumio[20777]: response: undefined Oct 29 11:18:41 volumio volumio[20777]: } Oct 29 11:18:41 volumio volumio[20777]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 11:18:42 volumio sudo[21695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-29 11:17' Oct 29 11:18:42 volumio sudo[21695]: 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"