Nov 02 05:09:00 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:00 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Nov 02 05:09:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:00 volumio go-librespot[26337]: go-librespot daemon starting... Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="app state loaded" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=info msg="zeroconf server listening on port 40949" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="obtained new client token: AACiNPNPxjgD5wbEfFECy/Sz7wjjxxPLEF2n77iR+UQBemRTN3rKrmL/qhPD2tJYqEuH1014YaHAKLe2hEwQ7zd8T/IDzU7lD+qJi9BwYvEjOKpdZuGY2A0VzYzfJwPDjHOlv9oegFwItFE542V9BHuB5QW3APSgmV350027fhFWtWjyoVsxl7/bFjTkgcTAXfifmOwM5wLAMha45hKJZKongkKyGVWUHBCaZFTG46RD+X2aJnXgYqs=" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="completed keyexchange" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=debug msg="completed challenge" Nov 02 05:09:00 volumio go-librespot[26338]: time="2025-11-02T05:09:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:03 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:03 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Nov 02 05:09:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:03 volumio go-librespot[26345]: go-librespot daemon starting... Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="app state loaded" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=info msg="zeroconf server listening on port 46679" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="obtained new client token: AABDdz04XNx6gdKa6I1BW+UKLYRC6kaL671Wa3XlUcxy32eNl0UbLGDUTEFdGYmjTN1+3BxNa0jfqfA6SmDnqt5Bk+lSkavVJWRGDPon6TU0dumNhdkYHhivsMvV2GeUWyVnAmsRC7J4cvuDUUiRey4zbFKpMsPbDag90CGaU0GuWLnR+LQp/73ouZ2aPqSRvm76wvyzlvM3ToJajwPyzOxBYxuAnB2UMYdD/By16IA3g7J/x0yOb5E=" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="completed keyexchange" Nov 02 05:09:03 volumio go-librespot[26346]: time="2025-11-02T05:09:03Z" level=debug msg="completed challenge" Nov 02 05:09:04 volumio go-librespot[26346]: time="2025-11-02T05:09:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:06 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:06 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Nov 02 05:09:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:07 volumio go-librespot[26353]: go-librespot daemon starting... Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="app state loaded" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=info msg="zeroconf server listening on port 37191" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="obtained new client token: AAA48x7TRpr0uYBjM3JVDJaZqfMSLkRioMKb88wJbc5fbOFg2hgkP0YaekU3TM/knL5Wcu6bXurfVHHabNaVfBmjom/9KqNZzzbhF/0AN9pfwzL6v+7D315p0cR69RwO2hzy8WibGo2kfZVt5f+T+3XXn6GosR/YLTZghY6RxOIgm62ut+3g8fQk2WNbrrmU+Ns72Iy/UVCohmzAL9Sjbtdue4bAEgpg/Vd4LLqvobSpYOHJEHNzgos=" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="completed keyexchange" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=debug msg="completed challenge" Nov 02 05:09:07 volumio go-librespot[26354]: time="2025-11-02T05:09:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:08 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:09:09 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:09 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Nov 02 05:09:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:10 volumio go-librespot[26376]: go-librespot daemon starting... Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=debug msg="app state loaded" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" 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]" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" 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]" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" 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]" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=info msg="zeroconf server listening on port 38379" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=debug msg="obtained new client token: AADeaksiNZ1o0kASJj+tajOOLthcOVM7ZNc8gK9v2gBfqH/JoadYgKkeaYjiDNx8uNxTvtBcmE71WpFdXclWfu8m4Q9PLx9WCKtkUpAUPfq6izudzNllnOmf5kkzzrwo0+rdkU3t2ZoU2V056nMA4DiR7IiLawZmD9+YLEmv21/elXbHaNXUW3fJ/icFHk4bZDKdiRYBUm+h5IRYAsmlJyOe1pOKoU6yAA9TPCBFEPAdgLZIFINSFYE=" Nov 02 05:09:10 volumio go-librespot[26377]: time="2025-11-02T05:09:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:11 volumio go-librespot[26377]: time="2025-11-02T05:09:11Z" level=debug msg="completed keyexchange" Nov 02 05:09:11 volumio go-librespot[26377]: time="2025-11-02T05:09:11Z" level=debug msg="completed challenge" Nov 02 05:09:11 volumio go-librespot[26377]: time="2025-11-02T05:09:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:12 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:12 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Nov 02 05:09:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:14 volumio go-librespot[26388]: go-librespot daemon starting... Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=debug msg="app state loaded" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09: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-gae2.spotify.com:80]" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" 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]" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" 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]" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=info msg="zeroconf server listening on port 46865" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=debug msg="obtained new client token: AAApIQq7TbpRP5VAQT0li7j4yX1vK4Ai62oBzIGreXIR5e0SLVghm5kd5on2F/dkSR8v6i1DSv6DMKNefOdpqqy7tBZYt3MphD2dMLTcod1n9ma3W1enbZf9NdkrdX7kho+vFn4/oQcZfM55C2Ps1BLtyo/8AImBHAvpOyzPQN/yWZVE4aP18C9si3iOKvjCKjPD6M3SW3H7jxNEutKqXe/6se4NMNECF5iMR3Ac+vvjEnn7iMLi/NE=" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=debug msg="completed keyexchange" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=debug msg="completed challenge" Nov 02 05:09:14 volumio go-librespot[26389]: time="2025-11-02T05:09:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:15 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:15 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Nov 02 05:09:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:17 volumio go-librespot[26396]: go-librespot daemon starting... Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=debug msg="app state loaded" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09: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]" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09: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]" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09: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]" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=info msg="zeroconf server listening on port 32803" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=debug msg="obtained new client token: AAB3CsU156d9eSrL/NNaGHfVMaxaZh4Q2GCTxL+l7DUT6J/xqnQ9xd3e3lpJLkMaI4NwLEN5ZSTcnzJW7VMXIrEb6JwhiXTt/5N13q4dFk6JcdiQ7xF7AWmhrG+Fw8S1OCtvv1ELgmhKcF7NZttYZNYSF4ku1RnMLHDiuqeRNQOCas/R9E3YJxA+rPXqTZkQl2bbWV5yQiyJdc4jgoG4Xhps/xfoqfG7ZJ7uAeyHax3bLiwj+atAHU8=" Nov 02 05:09:17 volumio go-librespot[26397]: time="2025-11-02T05:09:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:18 volumio go-librespot[26397]: time="2025-11-02T05:09:18Z" level=debug msg="completed keyexchange" Nov 02 05:09:18 volumio go-librespot[26397]: time="2025-11-02T05:09:18Z" level=debug msg="completed challenge" Nov 02 05:09:18 volumio go-librespot[26397]: time="2025-11-02T05:09:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:18 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:18 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:21 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:21 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Nov 02 05:09:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:21 volumio go-librespot[26419]: go-librespot daemon starting... Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=debug msg="app state loaded" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09: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-gae2.spotify.com:80]" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" 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]" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" 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]" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=info msg="zeroconf server listening on port 46511" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=debug msg="obtained new client token: AABqVBUVnixQboGgy5Bk1OtZ0Biwao0Z05e9k2p95u+lePJFU0vklrIbQVXvNzfLL5tzitp7+rl6ymLVGJwjzYDjCvNtyZ6bJ8lPufooPCAt5Yj/UuB1c0I1o4F2dmhiaYrLeylQhdgqLK1S8uXmLp1HOB4m4KLm9/o8vP5pVdSGtQXK+OTvuuRrxkNhMVhTP2oepaSR2RJeQQaZgZomZ8u//N3UH8jY08pnlrM/YpDOGDA2BwbYC7Y=" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=debug msg="completed keyexchange" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=debug msg="completed challenge" Nov 02 05:09:21 volumio go-librespot[26420]: time="2025-11-02T05:09:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:22 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:09:24 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:24 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Nov 02 05:09:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:24 volumio go-librespot[26427]: go-librespot daemon starting... Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=debug msg="app state loaded" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09: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]" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09: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]" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09: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]" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=info msg="zeroconf server listening on port 41435" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=debug msg="obtained new client token: AAAHy9AmvLQTrdJbmR/KHqLtJtV5mygSB7/XPhbmWqrhJ6ZqIkZGStZUPCKZ/vaOEGR6xgNi2npCp8BY565p6v+1dKTazcyQPzgIwsnzI7qzolqhFetNXQco4rACErMsd/N5Obvhu1JMvQH2tWRlC/0Mq1pkxT36/CVEOwdC9/qXNUcRZEHLc3Vn9n7G9/bEr2P8hL+0koBQRSkWj2R8d5igk5BiScc9x2C0yTpxkl0rk0jveIrkbMI=" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=debug msg="completed keyexchange" Nov 02 05:09:24 volumio go-librespot[26428]: time="2025-11-02T05:09:24Z" level=debug msg="completed challenge" Nov 02 05:09:25 volumio go-librespot[26428]: time="2025-11-02T05:09:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:27 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:27 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Nov 02 05:09:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:28 volumio go-librespot[26436]: go-librespot daemon starting... Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=debug msg="app state loaded" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" 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]" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" 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]" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" 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]" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=info msg="zeroconf server listening on port 37689" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=debug msg="obtained new client token: AADrWZPL7hAuzUyZ0wOFpSD8zVcHGSf2P3b1ANKJhZMy6e5ZkyRkydeiw2K7s5JQVzc0z70YqAn5hpvyiaY4wL/CPGPC+VrfuYjjusgvYA7noAGlHF+/8e9TsDuf/rMTltvtKwZjit50Jd82TXGZzEgs3qKg/bWPVFnomxhDGKhzkZjOUXLBmWDNsh3IMSsRj9x7YhM5c32NNox1UzT3mqw+7iR9u+8JE786mPu+R2mVdE6YtmpNKV4=" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=debug msg="completed keyexchange" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=debug msg="completed challenge" Nov 02 05:09:28 volumio go-librespot[26437]: time="2025-11-02T05:09:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:30 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:30 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:30 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:09:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Nov 02 05:09:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:31 volumio go-librespot[26458]: go-librespot daemon starting... Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=debug msg="app state loaded" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09: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]" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09: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]" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09: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]" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=info msg="zeroconf server listening on port 43041" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=debug msg="obtained new client token: AADrQffKsUshYV/98wEWn7UJeVvmRAqHTWDv7LbQS/Kby6jETSL4udBGwwaRdPaXfDjz9tfJ6A6i8yf+rpMzV0P98HmgyKRrfIq5ulEHPB26oNzvhLafnb/2Kr8ipbs1pdKRY81+hn3hLsmg7dvuU6hy8XJe9+HHqxMYEyGo4B0p2XFlSjSt3oMST5McOZ2At4CBAbGBbiM7rdXxq8hCpJyzpGaxWZeZCJpPTnLBTcDuoO1s7zzIHn8=" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=debug msg="completed keyexchange" Nov 02 05:09:31 volumio go-librespot[26459]: time="2025-11-02T05:09:31Z" level=debug msg="completed challenge" Nov 02 05:09:32 volumio go-librespot[26459]: time="2025-11-02T05:09:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:33 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:33 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Nov 02 05:09:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:35 volumio go-librespot[26469]: go-librespot daemon starting... Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=debug msg="app state loaded" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09: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]" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09: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]" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09: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]" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=info msg="zeroconf server listening on port 38883" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=debug msg="obtained new client token: AABRhSrBIu2KxOgi/zjTy+sBLrsKssMxmEHJHNfdGgRheMMegvynNH2LY8DN8Wm9zX9g2POylygOb5X441wNPkj0go+K0+0Ic+8+heEdYjD/fYY+EfbHpSJ+8Emkr7EipbV1iOsi3n1agSz8TJt8Ygl9sPVxEszFH0P++MV0QKS6nhSKiMRfNufByNg4hmY6hjnN18Q3I42KB0jPhTVuFWOdxMCm1ODMXLe0K7ZW0wMGGSBrTZhMpNM=" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=debug msg="completed keyexchange" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=debug msg="completed challenge" Nov 02 05:09:35 volumio go-librespot[26470]: time="2025-11-02T05:09:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:36 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:36 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:38 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:09:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Nov 02 05:09:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:38 volumio go-librespot[26491]: go-librespot daemon starting... Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=debug msg="app state loaded" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09: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-gew4.spotify.com:80]" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" 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]" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" 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]" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=info msg="zeroconf server listening on port 36027" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=debug msg="obtained new client token: AACbd3uUJ7eVZgnMGVECnrq/K5B+WBwJPu5GkgES0RM9SUfnonaC8QiYSAEinjJInzJk4U9J1s/fwlzPFhw+RkqpqlGZCWZ/ILbILoXi784QjqRh9eJtTlFC8Cba26a+XDJD2bBbxH/Pv2zOJrNp/O0VzQB4hzH7FeVkpurmL86SkYedmAFakOXZn3O8GlJk4pUpptHWInMd6r7FieVxsXujgJ+Gn2Cqv6KToxRnci85QlsZu/jW2c4=" Nov 02 05:09:38 volumio go-librespot[26492]: time="2025-11-02T05:09:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:39 volumio go-librespot[26492]: time="2025-11-02T05:09:39Z" level=debug msg="completed keyexchange" Nov 02 05:09:39 volumio go-librespot[26492]: time="2025-11-02T05:09:39Z" level=debug msg="completed challenge" Nov 02 05:09:39 volumio go-librespot[26492]: time="2025-11-02T05:09:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:39 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:39 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:42 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:42 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Nov 02 05:09:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:42 volumio go-librespot[26499]: go-librespot daemon starting... Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="app state loaded" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" 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]" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" 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]" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=info msg="zeroconf server listening on port 36321" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="obtained new client token: AABXQ9asDINTLWnwX/VxinP7EXTm633ev+ung809/GovnFZucf6A5AHzDZv/A0NrVPIC+nCkcIfFzxbe+RcqQ97UMUt3EqsJElqgCC7hRgDyFPQVG901jLQrVDKLmgDWNRDbQxpRD4Y1DG8/1yXuf1NqJA9wTuZQckMsd4bPgEI0VycXl9bN0c0/6erxgtcRa2YzV1/rCENdNn8VgkkuqeChFFoOcFVEA1wfqAKRhHSPvd6aJhG8L4Y=" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="completed keyexchange" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=debug msg="completed challenge" Nov 02 05:09:42 volumio go-librespot[26500]: time="2025-11-02T05:09:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:45 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:45 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Nov 02 05:09:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:45 volumio go-librespot[26507]: go-librespot daemon starting... Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=debug msg="app state loaded" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" 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]" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" 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]" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" 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]" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=info msg="zeroconf server listening on port 38087" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=debug msg="obtained new client token: AADz5MIfejQjceaRV7hgVvJTOS/JmIky8ltdykEp5hz7nCFP4PNRbo58MxF4p9wMBoof7hsWRSr/fSwj6lnFj4rGYT7D6rxDZIx3E0p4pvZiX4ZsmrFolK3wWM7XbHI6K8zXaAbW++2kDMKOKZDDyOooR4eX1aP9A/QlW0bUNqEQcZijqzbXuWkKLGxt2WdXl06j8Uv/Gz7Jp2tXjzLy6nWwb8A+tAJw3EUr/hfv0SrNStuz6jUKjm8=" Nov 02 05:09:45 volumio go-librespot[26508]: time="2025-11-02T05:09:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:46 volumio go-librespot[26508]: time="2025-11-02T05:09:46Z" level=debug msg="completed keyexchange" Nov 02 05:09:46 volumio go-librespot[26508]: time="2025-11-02T05:09:46Z" level=debug msg="completed challenge" Nov 02 05:09:46 volumio go-librespot[26508]: time="2025-11-02T05:09:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:48 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:48 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Nov 02 05:09:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:49 volumio go-librespot[26530]: go-librespot daemon starting... Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="app state loaded" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" 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]" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" 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]" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=info msg="zeroconf server listening on port 46011" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="obtained new client token: AAAlHck0peiERXf1ShJHUDNvdw2l9IWSfrSw/c8Ni9lsLzJUtaccMlPaQZ5EN3VExQDfb9iN+uoxdzW24bvMQ3HgTsRJcsQ8M4JX0OcnCFbprIxQv2gEW8p5xVHkQSoKz7a6i1xMuKINHCRt8nDt91ap+sdrSgOWRS1ymxvzVay9pWLPUgPM4ZvshGrCoziHaWOb4y8I6pvef/FEGCZLg46C/iW1Kj9RMJ7/VaUyUqL/hPSMiqDlkUM=" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="completed keyexchange" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=debug msg="completed challenge" Nov 02 05:09:49 volumio go-librespot[26531]: time="2025-11-02T05:09:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:51 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:51 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Nov 02 05:09:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:52 volumio go-librespot[26539]: go-librespot daemon starting... Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" level=debug msg="app state loaded" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" 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]" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" 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]" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" 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]" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" level=info msg="zeroconf server listening on port 35943" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" level=debug msg="obtained new client token: AAAiSCQw0kOiuPackBqePs3O4BnBJYSRCAnsaz2ATuWQzfjau5SMK8oETZ+0a8YEUJWlC9/MiYQbx1dy16oi5tYRElEnAV3kXiV9ZOA+hscyZchypdWTpxbYz4ZeznPLeK6LUx3/Hoqyl3Cs5js8BD5wuc2dL5l0iCXcY7UOcUBt/NhbeRoPseEcXuXMjho9EQijJ+O7li5ZKQiHaWNFongdy1fK4s4ra51/ZWWdCot8gn+0UJBZ6q8=" Nov 02 05:09:52 volumio go-librespot[26540]: time="2025-11-02T05:09:52Z" 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" Nov 02 05:09:53 volumio go-librespot[26540]: time="2025-11-02T05:09:53Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 05:09:53 volumio go-librespot[26540]: time="2025-11-02T05:09:53Z" level=debug msg="completed keyexchange" Nov 02 05:09:53 volumio go-librespot[26540]: time="2025-11-02T05:09:53Z" level=debug msg="completed challenge" Nov 02 05:09:53 volumio go-librespot[26540]: time="2025-11-02T05:09:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:54 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:54 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Nov 02 05:09:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:56 volumio go-librespot[26551]: go-librespot daemon starting... Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="app state loaded" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=info msg="zeroconf server listening on port 39559" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="obtained new client token: AAACPdIbNlD/uIQzNJZM+8oUBfJqm8OunNPynBVrKEQxZDtA4ldxmz0JAZCqiaQ/OKJJM8LVJDdOUuSy02XfERMzlkDLdWz1d/lsWyXghyc9o0pbnbUghmcKGxKPTGp72g2M/25m6soCj4cyFim9P7O7jO9KXtBDa8Ji3ADp8vWhbEyp2cNhDjrGWREKy5M/WlRE6RDlO3hYHarM1wCrtyVcNjg0P2s78wvfDGTro9XfEeyCQofa40I=" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="completed keyexchange" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=debug msg="completed challenge" Nov 02 05:09:56 volumio go-librespot[26552]: time="2025-11-02T05:09:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:09:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:09:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:09:57 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:09:57 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:09:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Nov 02 05:09:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:09:59 volumio go-librespot[26573]: go-librespot daemon starting... Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=debug msg="app state loaded" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" 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]" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" 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]" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" 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]" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=info msg="zeroconf server listening on port 44897" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=debug msg="obtained new client token: AABUmPbIRP4TmJItJ7PI6SBp+fWRZdXncyiUxlV3jxd2kjPq/KtsMfJAgzZ0tC03x5ZQTjWcU9JNQ2hUGMoYzp7IGHW+rjYc5UGOI63hQaRAdwg7dOI3FudakJaznUYrRP1MU8dC+/eadiA2C3FluCMCVUZZTxo0OycC9gfrv/tY/RvsKPlMGsCrb+J3L5LQ0TajmTESuZZON6scfX4yWRaIRDsPPFtlvoXPcwEpadDCx6PlmKYn1vA=" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=debug msg="completed keyexchange" Nov 02 05:09:59 volumio go-librespot[26574]: time="2025-11-02T05:09:59Z" level=debug msg="completed challenge" Nov 02 05:10:00 volumio go-librespot[26574]: time="2025-11-02T05:10:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:00 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:00 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:03 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:03 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Nov 02 05:10:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:03 volumio go-librespot[26581]: go-librespot daemon starting... Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=debug msg="app state loaded" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" 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]" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" 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]" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" 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]" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=info msg="zeroconf server listening on port 37019" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=debug msg="obtained new client token: AAD4M1ttdK1QWgu+tALTqO58q2ZF1o076NNPxIpr0w3zhiQk1LDjct7EhaVbwOvpolqyo4wH+N4Xme4bqtmJDrn7Odjg8kelPIwbhioPF/eSWJwngiXB9kTzoKsjfDF6Ppzo0MyVExakC7jFJISo+iqT4z7LmqzMnBkW6KKHZPJBp/LKypdD3Z/dc2aOxpKOtQFCtGigfIoHiDYFlZriWND0WpIX0lNv6aumWoaw07xy3oUQWEfpH3Y=" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=debug msg="completed keyexchange" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=debug msg="completed challenge" Nov 02 05:10:03 volumio go-librespot[26582]: time="2025-11-02T05:10:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed peeking unencrypted bytes: failed peeking uncrypted: EOF" Nov 02 05:10:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:06 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:06 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Nov 02 05:10:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:06 volumio go-librespot[26590]: go-librespot daemon starting... Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=debug msg="app state loaded" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10: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-gew4.spotify.com:80]" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" 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]" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" 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]" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=info msg="zeroconf server listening on port 43883" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=debug msg="obtained new client token: AABLZBicXKgUA1y6xDzrynAyvL5Ek17Vqciq9sM7p/33zjLt06WVH/iSF503u419b7Ucne8VPND6sWhc+Tcrm9xiSReT3k0XLOiu4yseZWTM1gp/S/yhmcX+GY4xNGfXmFO2F4FXeyqwPpZzaRGlhYqT59UWLAvx19mgDgz5gIrTbnkDqdGHr6HvA4l7vTuWWskIe8BRPle9yZkKTWYLXDHCB7Pd3IpiHbSIKyz29XFjbEBAGVpsetA=" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=debug msg="completed keyexchange" Nov 02 05:10:06 volumio go-librespot[26591]: time="2025-11-02T05:10:06Z" level=debug msg="completed challenge" Nov 02 05:10:07 volumio go-librespot[26591]: time="2025-11-02T05:10:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:09 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:09 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Nov 02 05:10:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:10 volumio go-librespot[26614]: go-librespot daemon starting... Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=debug msg="app state loaded" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" 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]" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" 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]" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" 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]" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=info msg="zeroconf server listening on port 34225" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=debug msg="obtained new client token: AACsktWdfBvQjvrljJzIQj5qOSaSVBxtxxLnc8vefqiF0HncdKBh6l0xjR+4zxz7pNLibVOes6XMerY8Y5oXDTgbdXz6UCmwjDp3RsEzPz3MhVJZuUf4iKfcdBUJ28BkX/UD8kroH2MH8ryXu1bYbdkWlW20AuAb+xHrRIDCZnNJV7uX+bo1D7GjJyaiTUclm6LrRvjbHD5rN0g9fRCs8QrSkkdqGf5Lo6QQQ0ORK/WdFe3Z2mduyKU=" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=debug msg="completed keyexchange" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=debug msg="completed challenge" Nov 02 05:10:10 volumio go-librespot[26615]: time="2025-11-02T05:10:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:12 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:12 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Nov 02 05:10:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:13 volumio go-librespot[26622]: go-librespot daemon starting... Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=debug msg="app state loaded" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10: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]" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10: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]" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10: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]" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=info msg="zeroconf server listening on port 34971" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=debug msg="obtained new client token: AAAdlZbJ+hlF4SpHcvHDzB0VmFkhfBjpJ55KW8YH/kTbFoPguSfIs6UtMPA/mKqFs0mL2wCtK/K1kqT4hzGJZud3R1u+CEVh1zTl5VattWA1iA4cbHMbxMr2PVZ4UezfKBRXwkn9YwAfYei/DqcJgZi0dcJoiqj1mtc6DN1uz8aTZ+efNXZTfI/QTc3LXozHq589gSusp+hZlRqi3keLSGbmLgmmj2K49rUyYzqXwO9xUcZCKrcBmI0=" Nov 02 05:10:13 volumio go-librespot[26623]: time="2025-11-02T05:10:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:14 volumio go-librespot[26623]: time="2025-11-02T05:10:14Z" level=debug msg="completed keyexchange" Nov 02 05:10:14 volumio go-librespot[26623]: time="2025-11-02T05:10:14Z" level=debug msg="completed challenge" Nov 02 05:10:14 volumio go-librespot[26623]: time="2025-11-02T05:10:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:15 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:15 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Nov 02 05:10:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:17 volumio go-librespot[26633]: go-librespot daemon starting... Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=debug msg="app state loaded" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" 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]" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" 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]" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" 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]" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=info msg="zeroconf server listening on port 42523" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=debug msg="obtained new client token: AABp3eN0bxhNtELgihhc4B6ZLsRON1mXJJ4Y+tHXNOYI/KmDsd833Ejzin3URsZzNE3NsYj61sNbltAnwgBNNpYZtiQyHWvauXJKPrHJ6KygbzBUA7db0aCa0ahol9t3j7Fqt4VEvifSJsip06Z2km/R36DlYWBw1mDgvVJwmyzxOokYZNk6euKj+nDV/M0LhBvnVUqGK+JlKRLtJz0pk4LQ2gtb5Ql4kmcSr0Y7pFsMGaRNPXpOkk0=" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=debug msg="completed keyexchange" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=debug msg="completed challenge" Nov 02 05:10:17 volumio go-librespot[26634]: time="2025-11-02T05:10:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:18 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:18 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125. Nov 02 05:10:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:20 volumio go-librespot[26655]: go-librespot daemon starting... Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=debug msg="app state loaded" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" 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]" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" 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]" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" 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]" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=info msg="zeroconf server listening on port 35773" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=debug msg="obtained new client token: AADaVy+I4BU7+EbC/9N6RgZL/LSmhvSdUn5abaMH33WLN/oz25EtQdVX6au4Pjr8IhOr/xKddhOiSdRZTCJOsGTh3HSWnRImrgy2rnYJndKFJ/vfXlzP9wHUNU/+CCIANqi8bE8GoBRrEFk1FEakc+9xd5l8B75ZGzGgGTpZ5P2m9Sm1my9Ay++4gnqa38b+k6mVfcsWSp2MW6XPwJ+dMiCUQNnSJgiOmszcU2IizpL9rGfXqPmAQb8=" Nov 02 05:10:20 volumio go-librespot[26656]: time="2025-11-02T05:10:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:21 volumio go-librespot[26656]: time="2025-11-02T05:10:21Z" level=debug msg="completed keyexchange" Nov 02 05:10:21 volumio go-librespot[26656]: time="2025-11-02T05:10:21Z" level=debug msg="completed challenge" Nov 02 05:10:21 volumio go-librespot[26656]: time="2025-11-02T05:10:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:21 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:21 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:24 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:24 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 126. Nov 02 05:10:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:24 volumio go-librespot[26664]: go-librespot daemon starting... Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=debug msg="app state loaded" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" 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]" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" 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]" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" 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]" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=info msg="zeroconf server listening on port 36925" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=debug msg="obtained new client token: AADQEkG7HB+HZbzxhD93I0lIKKWWU1GLQgIHvNZQbfh2wdD0ZkEfre7PvkTfTQzAeHh92e4FEhlozj4moQ/hji26tc+4csDvspfR4mszRtgucrwBvKIyiVZ+0w1uhXBO+UXz5AXH3sTbhW95cgSYNnL3qNlTzbBgaMrsotxJm6NtelECdRCiXMcfPgmQrWZgArMjXhtj4sLRh/2uDuYtHyasOGz+MdMwLvxL3z1sbgyrll1XWDX2ri8=" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=debug msg="completed keyexchange" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=debug msg="completed challenge" Nov 02 05:10:24 volumio go-librespot[26665]: time="2025-11-02T05:10:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:27 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:27 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 127. Nov 02 05:10:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:27 volumio go-librespot[26673]: go-librespot daemon starting... Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=debug msg="app state loaded" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" 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]" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" 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]" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" 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]" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=info msg="zeroconf server listening on port 42629" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=debug msg="obtained new client token: AAAhcItTWb1UxufipBIHV4vRVLHccAm+31KFOkRYsK/u4mRzec5qaec6VrVSQfmG1g7vSNqsLjAqBu1ckuzVQIYlQSB46ZfEg5hxCruwl8eyTz0SzO+65ci26E0WQMfIEM+Sda2SkShHU2EF4QRxPGByGpNTQt2BLvv+ftcCVbywgNLbmKzCGvpX2dSs1YSPmO1Ucg5OJtX6x6qZkEdKawgOkCcgTWg8GHyPTW6I0hyb0e/KDN/JBnU=" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" 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" Nov 02 05:10:27 volumio go-librespot[26674]: time="2025-11-02T05:10:27Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 02 05:10:28 volumio go-librespot[26674]: time="2025-11-02T05:10:28Z" level=debug msg="completed keyexchange" Nov 02 05:10:28 volumio go-librespot[26674]: time="2025-11-02T05:10:28Z" level=debug msg="completed challenge" Nov 02 05:10:28 volumio go-librespot[26674]: time="2025-11-02T05:10:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:30 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:30 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 128. Nov 02 05:10:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:31 volumio go-librespot[26696]: go-librespot daemon starting... Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=debug msg="app state loaded" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:31 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" 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]" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" 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]" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" 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]" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=info msg="zeroconf server listening on port 46375" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=debug msg="obtained new client token: AAARq7oS/gMvvYShmHk+ahWc6dxLQNGLYKTkeFwng3U3GEBhQBa4y5NCht6lKTr0h2NALEKA3IlQEwNDStBGtBOcUS9YgKqQwUs2KYoIAw67HxRcGhHCjBLr5BulmcrGYXGkWXfhS+Pnyu8HXIJ81aN2/gGVB+O3UwDZ08E6BdCsRF+g2VphxG9pQrtgw4r7WTshb7R/c/zTpIaWHEluf0AhtqtM1NmQIxT3OXK4gi1TSfsp1nC29a8=" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=debug msg="completed keyexchange" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=debug msg="completed challenge" Nov 02 05:10:31 volumio go-librespot[26697]: time="2025-11-02T05:10:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:33 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:33 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 129. Nov 02 05:10:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:34 volumio go-librespot[26708]: go-librespot daemon starting... Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=debug msg="app state loaded" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" 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]" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" 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]" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=info msg="zeroconf server listening on port 33387" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=debug msg="obtained new client token: AAAwYWQg3K6xAeTtqMxkq86dlzP249TMj+AXU4olzFvC8jkT9Flp8G5/OWq5ftS4tvARM+k+J62G1MZsiHpSCUtY1GKjXQBYjpS3WAwuRCwf1icVsRKweiSWWsYf0HmWsZZQBSRdlil/dUCTrDo7zA9FYobJsuuOCioA/dQ1oEaywR3d+OiE3Ge3793da0ngZD1d/njTYXOScdq1znX63CGkYzHzROE7yUN+cLkHJibVkqFWmfBUTLU=" Nov 02 05:10:34 volumio go-librespot[26709]: time="2025-11-02T05:10:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:35 volumio go-librespot[26709]: time="2025-11-02T05:10:35Z" level=debug msg="completed keyexchange" Nov 02 05:10:35 volumio go-librespot[26709]: time="2025-11-02T05:10:35Z" level=debug msg="completed challenge" Nov 02 05:10:35 volumio go-librespot[26709]: time="2025-11-02T05:10:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:36 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:36 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 130. Nov 02 05:10:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:38 volumio go-librespot[26716]: go-librespot daemon starting... Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=debug msg="app state loaded" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" 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]" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" 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]" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" 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]" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=info msg="zeroconf server listening on port 36567" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=debug msg="obtained new client token: AAAQ11TaX7sPyCi8WeSDkaRHV6OoQbX6cOR7m0+Tnyu/FmsFkXylKuPgRRJ7iSSHrnP3bbJkdqGGSZsPI1mgcwSG4EEeDYwK0Im2SvrYqT7jhS5JLM3moc1UkbGDktk0C5kPhuSdxi6Lj1bmxOb+PPzj9YiuZE/3v9Fc2G7l871EABlB9+lM/vzHmD+5vqaBdIPts5Bv4VBIIxXtPgN3Gz6toUsbyyzaJI7b22hS+fIMeLkPxMgxR1g=" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=debug msg="completed keyexchange" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=debug msg="completed challenge" Nov 02 05:10:38 volumio go-librespot[26717]: time="2025-11-02T05:10:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:39 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:39 volumio volumio[25518]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:41 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 02 05:10:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 131. Nov 02 05:10:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 02 05:10:41 volumio go-librespot[26738]: go-librespot daemon starting... Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=info msg="running go-librespot 0.4.0" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=debug msg="app state loaded" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" 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]" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" 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]" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" 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]" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=info msg="zeroconf server listening on port 38255" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=debug msg="obtained new client token: AACzE9cqlrplBd+67g9B2hSemH/egbfUD8yqCYvtgD7tfNVDDSr26gYZ2fFoeIGaCINFwXbCBg4aCDfe2mZwuIwWH6my/a5J+KswX/Iq+r2OhjOnJJ3pNdwAWmIQn/pfzAiEPdg3jxqyPRH/wSvkONdgtbWu0+SFfDynHdMPpTVr3xJFZgZebVLnMS37bcWaN5tRv1VkNXGYRwR7AYTAGwIb3ZMtfjVOKylbQQL8onop4iAB45R8ed0=" Nov 02 05:10:41 volumio go-librespot[26739]: time="2025-11-02T05:10:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 02 05:10:42 volumio volumio[25518]: info: Initializing connection to go-librespot Websocket Nov 02 05:10:42 volumio go-librespot[26739]: time="2025-11-02T05:10:42Z" level=debug msg="new websocket client" Nov 02 05:10:42 volumio volumio[25518]: info: Connection to go-librespot Websocket established Nov 02 05:10:42 volumio go-librespot[26739]: time="2025-11-02T05:10:42Z" level=debug msg="completed keyexchange" Nov 02 05:10:42 volumio go-librespot[26739]: time="2025-11-02T05:10:42Z" level=debug msg="completed challenge" Nov 02 05:10:42 volumio go-librespot[26739]: time="2025-11-02T05:10:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 02 05:10:42 volumio volumio[25518]: info: Connection to go-librespot Websocket closed Nov 02 05:10:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 02 05:10:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 02 05:10:45 volumio volumio[25518]: info: Getting Spotify volume Nov 02 05:10:45 volumio volumio[25518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 05:10:45 volumio volumio[25518]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 02 05:10:45 volumio volumio[25518]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 02 05:10:45 volumio volumio[25518]: errno: -111, Nov 02 05:10:45 volumio volumio[25518]: code: 'ECONNREFUSED', Nov 02 05:10:45 volumio volumio[25518]: syscall: 'connect', Nov 02 05:10:45 volumio volumio[25518]: address: '127.0.0.1', Nov 02 05:10:45 volumio volumio[25518]: port: 9879, Nov 02 05:10:45 volumio volumio[25518]: response: undefined Nov 02 05:10:45 volumio volumio[25518]: } Nov 02 05:10:45 volumio volumio[25518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 05:10:45 volumio sudo[26761]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-02 05:09' Nov 02 05:10:45 volumio sudo[26761]: 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"