Nov 05 20:05:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Nov 05 20:05:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:01 volumio go-librespot[18348]: go-librespot daemon starting... Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=debug msg="app state loaded" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" 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 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" 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 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" 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 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=info msg="zeroconf server listening on port 40247" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=debug msg="obtained new client token: AADcwc4EBffWvYQsaMhFFRvXZZ+qc+d5Jyn3vNmENLZI9oli4vdzudBuKyZW7yJwdDYdM7XHrHJ+9BMdzJdEHkO7F6WIiY/4M09XFsy2mkdd5m774436IdnVFbU3uy49TkR0VMK8Urg8RkAsLQDpHIHC7OtWIluv/VdYqc9O55OlDrEkx3+mY2Mw2eSJm1uK5SZlT0+aaELDnzZQszTNeF1lfOr8n6089aDkA9lvSwQ8QPc/rNgQq2U=" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" 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 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=debug msg="completed keyexchange" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=debug msg="completed challenge" Nov 05 20:05:01 volumio go-librespot[18349]: time="2025-11-05T20:05:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:01 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:01 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:04 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:04 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Nov 05 20:05:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:04 volumio go-librespot[18371]: go-librespot daemon starting... Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="app state loaded" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=info msg="zeroconf server listening on port 44141" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="obtained new client token: AAB7aPeq0rvRhEbIo7SJuHU/OvvYmjRvAdwPi9LGpKKgncewGYt6s522SDdyYIvun4ZSrrX1GiWBe8scfmY1vKoNreGmiDlzsU4ftArJha0C6kkanPiM7+/1QL5EbIh+Ciu+kWHiWdoT2r3HdwnRiEX4P8ZwBrL8xsrn+oH0cc0U8i2bD/O+GMsua0oyB6kI8azZXx3AALdpOlLkpGwCk4UIq3rxE/SET+ugzs5MFNd4Jo8COvTAV6c=" Nov 05 20:05:04 volumio go-librespot[18372]: time="2025-11-05T20:05:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:05 volumio go-librespot[18372]: time="2025-11-05T20:05:05Z" level=debug msg="completed keyexchange" Nov 05 20:05:05 volumio go-librespot[18372]: time="2025-11-05T20:05:05Z" level=debug msg="completed challenge" Nov 05 20:05:05 volumio go-librespot[18372]: time="2025-11-05T20:05:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:07 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:07 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:07 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:07 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:07 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:07 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Nov 05 20:05:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:08 volumio go-librespot[18379]: go-librespot daemon starting... Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="app state loaded" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" 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 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" 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 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=info msg="zeroconf server listening on port 37193" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="obtained new client token: AACc4jdn3pOW1Rdy1lyr40vUY0Zy+5cXebydT9BwGCytd8kPuhwbGMZwf2YlD9bwYX54ZgLLdMH3oGY6lsXCNAeV+Pv1xELz81ZoUgZp9gNf17FUyrx82I1DOQme4LXwnggUhNkAeJTLgVrm0dnjje2qSleC5ZRRRxMz6JPGktLO0hOicStMGUAhCKOIlS2LQb5sfVPpYv0+zlxMyigYdUtIXPdtZoFPWxve0e0alNRGa5GuOeolm7M=" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="completed keyexchange" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=debug msg="completed challenge" Nov 05 20:05:08 volumio go-librespot[18380]: time="2025-11-05T20:05:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:10 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:10 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Nov 05 20:05:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:11 volumio go-librespot[18388]: go-librespot daemon starting... Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=debug msg="app state loaded" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" 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 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" 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 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=info msg="zeroconf server listening on port 40963" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=debug msg="obtained new client token: AAC5tJ5uRZhu+olB+WCSvY38xyLcj36CvuOZFYvs1z9ffNeEiCjEUGPDzpGWfYvynuhRI2hDT4csrrwTgVzFftM7zUO2qgl0/BjKQTFGSlMjg/WMjSl+iKatsSOJIY6sy+tyw9YqMEKzpXinll1OkQpM6/MitdChVXqK8F5PvJ4OZiTRCBf5CQw997bn/VCXHOR90SXERP2+6bginnxmJwL8cChTQmCGO57Pr9eBG+9+uqePyJl7XyI=" Nov 05 20:05:11 volumio go-librespot[18389]: time="2025-11-05T20:05:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:12 volumio go-librespot[18389]: time="2025-11-05T20:05:12Z" level=debug msg="completed keyexchange" Nov 05 20:05:12 volumio go-librespot[18389]: time="2025-11-05T20:05:12Z" level=debug msg="completed challenge" Nov 05 20:05:12 volumio go-librespot[18389]: time="2025-11-05T20:05:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:13 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:13 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Nov 05 20:05:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:15 volumio go-librespot[18410]: go-librespot daemon starting... Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="app state loaded" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" 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 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" 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 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=info msg="zeroconf server listening on port 43107" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="obtained new client token: AAAjMk5ZooK4URQM9o3XYg0FJXP8yHj8JHj7lYdPmAbO4OQJwcApK+h4eNyjpZW4TUB+lrm+8YbvSaMMihlWHWp3kFS42L/pfcd5sPWOPhTo+EocO0PJAdIyLnbuJ2Y5pvTZvNBaXakxI4XPA3GcGi8z4OMLrE7Brs39IxCC1fpsBRUgDGKHJ8gVqJ5bap+szw8MVmcfLUajLgcgtK850cyFNC0U3prDscPP3qn608mPaOI3DHUlyjc=" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="completed keyexchange" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=debug msg="completed challenge" Nov 05 20:05:15 volumio go-librespot[18411]: time="2025-11-05T20:05:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:16 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:16 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:17 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:17 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Nov 05 20:05:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:18 volumio go-librespot[18418]: go-librespot daemon starting... Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=debug msg="app state loaded" Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" 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 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" 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 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=info msg="zeroconf server listening on port 44633" Nov 05 20:05:18 volumio go-librespot[18419]: time="2025-11-05T20:05:18Z" level=debug msg="obtained new client token: AADTHjmovG998fiZbBFtYnuyn2cCYdef4HWXDodq8M6MXx6+VL90SoEv7XGWn61NyoniLNiRjcnLPtWN+4b6gT7XtncV9kHG8Kxxzd9JNdahO2DLawjCD70dp0y7kSTDJPzPBzCiLg1Nbd4CSnVZTUGwXebvHaS9Zz3VUpmozPeVI840Auh5AXQhd7De7k4ofIqEdGV66fSfGV/eJj2B/Ug+mBr8gPFksedrZQZCpmmbknFdsCnVxnw=" Nov 05 20:05:19 volumio go-librespot[18419]: time="2025-11-05T20:05:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:19 volumio go-librespot[18419]: time="2025-11-05T20:05:19Z" level=debug msg="completed keyexchange" Nov 05 20:05:19 volumio go-librespot[18419]: time="2025-11-05T20:05:19Z" level=debug msg="completed challenge" Nov 05 20:05:19 volumio go-librespot[18419]: time="2025-11-05T20:05:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:19 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:19 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Nov 05 20:05:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:22 volumio go-librespot[18431]: go-librespot daemon starting... Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="app state loaded" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=info msg="zeroconf server listening on port 40093" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="obtained new client token: AABCbzpxY40TRLKE4AtYN3ooYM20wJRclfLJwFGXWCFeLBRpeSEYWD10qSqxGt0BpKRa5ctffdF6H+YTy5MDwDQzjTfleK4JW6ZOPIdtFmIRoa2iA718KW/sP83sJw+aI2jF/qzIxfz16KPmk/6ffbWsdFHfiIYHdoPz4mb8+KODkUa/Lk8+suXr3NKsENMXrd5jA5Iz/Yg8kUYYew9AlcbvcRwWCQWv5/sfaOaeiPBpBI2iZDVbirg=" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="completed keyexchange" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=debug msg="completed challenge" Nov 05 20:05:22 volumio go-librespot[18432]: time="2025-11-05T20:05:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:22 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:22 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:25 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:25 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Nov 05 20:05:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:25 volumio go-librespot[18453]: go-librespot daemon starting... Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=debug msg="app state loaded" Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" 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 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" 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 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=info msg="zeroconf server listening on port 33859" Nov 05 20:05:25 volumio go-librespot[18454]: time="2025-11-05T20:05:25Z" level=debug msg="obtained new client token: AAAiAycuQ1jletMrwBLW3Rbw7htLghYMyw9PfcG7ZuRFK0FNR99hYrGPEX+FZWGpoon1DeZwLLWVpJI1+MGuWcl1aZHUCuNqVYd/QEKII8I6mIXiM79HKPBbn8Sjbo7sj3vX/Cb8e8jcbjByYKVGj7nhGtWPKxxJGNUQtEtL1h+mLORHkSTNfLciHWAWOUShbzBHS/ildgfKkYW0qgrqv7ShqEVapao6Ase95I0HF3G9jb/TfYT/Eos=" Nov 05 20:05:26 volumio go-librespot[18454]: time="2025-11-05T20:05:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:26 volumio go-librespot[18454]: time="2025-11-05T20:05:26Z" level=debug msg="completed keyexchange" Nov 05 20:05:26 volumio go-librespot[18454]: time="2025-11-05T20:05:26Z" level=debug msg="completed challenge" Nov 05 20:05:26 volumio go-librespot[18454]: time="2025-11-05T20:05:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:27 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:27 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:27 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:27 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:28 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:28 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Nov 05 20:05:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:29 volumio go-librespot[18461]: go-librespot daemon starting... Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="app state loaded" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" 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 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" 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 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=info msg="zeroconf server listening on port 43317" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="obtained new client token: AAARARaihyRbXqoJKDeUi8iJNPZ2o5slkp4iyHcrBtmtx1gBahUEpNKiHXyPMarTSVV9CzxyqQ5iT5mAE9fMkUY00jBCFm0fNHSFStoWX8bjWnjxKCGyNPyMm2OJsoWcq7UNqaLDXAa811pz6KJgQbpjblnLrOWN/p+BJULP95BeHopL5b+UaXBZ/lRJLjJIlAIB2UtDYigIhVF8N8+xJ1Fp0punhWcFOwzqcsNXXtbpsq2VR0tr3vU=" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="completed keyexchange" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=debug msg="completed challenge" Nov 05 20:05:29 volumio go-librespot[18462]: time="2025-11-05T20:05:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:31 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:31 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Nov 05 20:05:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:32 volumio go-librespot[18469]: go-librespot daemon starting... Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=debug msg="app state loaded" Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" 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 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" 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 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" 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 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=info msg="zeroconf server listening on port 44875" Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=debug msg="obtained new client token: AAB9V+Vrf3mr1EVmGieCJdGMYUoP6IqK18So3VB7kw86y9GkyX6tju9VlsWmRjNIppceweDn0q9XpkAJPWoHKLQgwb+MN9jZ53yL7gSWB4CUl96zWcds91tIJdKvgUQQ7w374juvS1kHUs3/SaAq8e1M4O2WN+xi1KRDA3U/a57dJo1w+6jk7ZOb7djTZRd7KZsalEEF+R+qnthL2jcJ7oTWbeLjfjfH1u7Pt0ZeCcJS+kcpXn4lGlE=" Nov 05 20:05:32 volumio go-librespot[18470]: time="2025-11-05T20:05:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:33 volumio go-librespot[18470]: time="2025-11-05T20:05:33Z" level=debug msg="completed keyexchange" Nov 05 20:05:33 volumio go-librespot[18470]: time="2025-11-05T20:05:33Z" level=debug msg="completed challenge" Nov 05 20:05:33 volumio go-librespot[18470]: time="2025-11-05T20:05:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:34 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:34 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Nov 05 20:05:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:36 volumio go-librespot[18491]: go-librespot daemon starting... Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="app state loaded" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=info msg="zeroconf server listening on port 34235" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="obtained new client token: AABS7NuAOYnjUc+fpR9q3nnadu3CyHkyOjtNKzlwUhInc2aH/M/GHk5ASRJXC+pJjQ/5ddWrkKvOVFxi67Hz75636P4B93mhP0WHN1AVtP+lfIoSZo9PS7S4Ucl95+8UWq8rCL6UXUsirfAqRcxoXo1SEeNJ7AEGE3y9oX/dchwxV4KSWh7wq1HcfKSRG24ECFkjpBlnXk3QauwOGPQFIhHkSwTPdI59XT0rM1whTcgcXJC6nviZR84=" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="completed keyexchange" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=debug msg="completed challenge" Nov 05 20:05:36 volumio go-librespot[18492]: time="2025-11-05T20:05:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:37 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:37 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:37 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:37 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Nov 05 20:05:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:39 volumio go-librespot[18499]: go-librespot daemon starting... Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="app state loaded" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=info msg="zeroconf server listening on port 39911" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="obtained new client token: AAAMBpLDPdpbQidQQm7pg8eZlWeB5t6YPIrJns3GZbnmGVTRiWjjA/asega5fYb7hYYCfYN2lWgSKGsWQ4D6HOro8U0D+qW+MQfWjkzyIz1N9N/oznDCVUr/Aa3uYwArz21woLPQezuIbertyGIs5BgZlhbMN/1SxF151tWzu49hABz5z+Qtj4mJWHCbgnNaeU+kfihiE3xT8q/a5sXpDsuVWuc3ncrqCXupMdlZOvYHVwZNF/7S7AI=" Nov 05 20:05:39 volumio go-librespot[18503]: time="2025-11-05T20:05:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:40 volumio go-librespot[18503]: time="2025-11-05T20:05:40Z" level=debug msg="completed keyexchange" Nov 05 20:05:40 volumio go-librespot[18503]: time="2025-11-05T20:05:40Z" level=debug msg="completed challenge" Nov 05 20:05:40 volumio go-librespot[18503]: time="2025-11-05T20:05:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:40 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:40 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Nov 05 20:05:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:43 volumio go-librespot[18510]: go-librespot daemon starting... Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="app state loaded" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" 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 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" 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 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=info msg="zeroconf server listening on port 38707" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="obtained new client token: AAAJYvXgRnRsCvAbOd6886cdDaUKE1vnzVoPJIrzGJDOVH8JyNidmK6gPDOqSNxzeUhobz0U0usdEPzxPLD+14XjdRpBrTJV/TcuLzorPk5nqLh3qqCwoSX3zRivwQcMeFxsTaqH8ZHhJmakShzRLYijRJeEr8rUsJGedP5OjdkMJ3bao/TtiyWkuwTA1IWwyLfsPK1dNmL3Eg3G83Qv0SDdQARmkkxrB08++TzAHkVcpyPO2NwZH4g=" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="completed keyexchange" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=debug msg="completed challenge" Nov 05 20:05:43 volumio go-librespot[18511]: time="2025-11-05T20:05:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:43 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:43 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Nov 05 20:05:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:46 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:46 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:46 volumio go-librespot[18533]: go-librespot daemon starting... Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=debug msg="app state loaded" Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" 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 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" 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 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" 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 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=info msg="zeroconf server listening on port 45989" Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=debug msg="obtained new client token: AABkx9wAKNZWPLfgFzdfhj4UYpmUjTNsowq7VKPQDFUmmm4aA65DWhxBIgXrAlvC3rk0XL+8fVzAxlx1KL2ON0I7/rNFtozlpt+A4M8EVxMPB4jxJmuFxVpHvejNBVjPW+dK+I5ON9hgdNVJM9UhLlkDx5n0k5VJYmnEX98bvuZO1MWSFWmsCvaXKdblKGbhhE0lgRTFkeLmYKjOQNApiYnQHPctUURQhjkPa6VgXOHhlnb+JgfEZv0=" Nov 05 20:05:46 volumio go-librespot[18534]: time="2025-11-05T20:05:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:47 volumio go-librespot[18534]: time="2025-11-05T20:05:47Z" level=debug msg="completed keyexchange" Nov 05 20:05:47 volumio go-librespot[18534]: time="2025-11-05T20:05:47Z" level=debug msg="completed challenge" Nov 05 20:05:47 volumio go-librespot[18534]: time="2025-11-05T20:05:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:47 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:47 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:47 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:47 volumio volumio[17635]: info: Listing playlists Nov 05 20:05:49 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:49 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Nov 05 20:05:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:50 volumio go-librespot[18541]: go-librespot daemon starting... Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="app state loaded" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=info msg="zeroconf server listening on port 32795" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="obtained new client token: AABcYKHKWhNDWAhiIVdr7JMLZL5tMMUM8Jw90MAQy22E5F/nngDxY+nLA3FH6IWPqotk280Ed8Y+4ZiW9Ekh4UnyzCF4heeA5/QLf0/24ng/nDeCeJu1ThMAN06Ozkc/yltoRWM+U9BTvSvnagbS00Vr2u4AGNL/XXtGLVXpwSulueGGqe/ESHrT1dLjZRI0ShMs8qrJFNYg8cmQcyD3ojkUJe3Q71GoIkGBZAE6c6jtdrDXrnA/TsM=" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="completed keyexchange" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=debug msg="completed challenge" Nov 05 20:05:50 volumio go-librespot[18542]: time="2025-11-05T20:05:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:52 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:52 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Nov 05 20:05:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:53 volumio go-librespot[18549]: go-librespot daemon starting... Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=debug msg="app state loaded" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" 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 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" 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 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=info msg="zeroconf server listening on port 38545" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=debug msg="obtained new client token: AAB6EazJn2y3jcBwxJy8oGvN9PSqzdUaOBgQ1tXvZKe3klsZHR1pj9kCMWKRPX46Cod2q3eQ4mKrkmkmFgfIKdSu+glZ5ExV2/hNvVVZTEi7dcPGjh5EyaoM92Yz9BnnL1A6kczMv8Yzmpcs9fxY0JFn7CbKhI8Fvr6y2CZE7zjhjZakuuw6Kcrz05T0esXeGcPhQYCRh2AwYzEHH/hmTIHKCQ4fl0h5vF8d+WWeoVEVer6r/KziUoo=" Nov 05 20:05:53 volumio go-librespot[18550]: time="2025-11-05T20:05:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:54 volumio go-librespot[18550]: time="2025-11-05T20:05:54Z" level=debug msg="completed keyexchange" Nov 05 20:05:54 volumio go-librespot[18550]: time="2025-11-05T20:05:54Z" level=debug msg="completed challenge" Nov 05 20:05:54 volumio go-librespot[18550]: time="2025-11-05T20:05:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:55 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:55 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:05:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Nov 05 20:05:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:05:57 volumio go-librespot[18571]: go-librespot daemon starting... Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=debug msg="app state loaded" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" 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 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" 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 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" 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 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=info msg="zeroconf server listening on port 34635" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=debug msg="obtained new client token: AADjpL1eJbWm5XxDNqzv8k8e3C3r1V0WirQOJLEEbXTpu7pZisq5azZ0SfZ/MC4AtPFOnClLyGiCZbpeEXx/WOi4Mud38pwz3L3wonNzX9kk4tYs4gFPQJ6nATfIQ5G2IZ7rvYMnRpQ0eHS9LoQcam6A1P0DYJVPZWloKDrLOzUyprURLaAfC1JQEKKM+Vz6/FD54weyxnCq7gxEbFUxwcFoGWN7tWkHfTKjrJlKRONMuzC+w8nsCss=" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=debug msg="completed keyexchange" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=debug msg="completed challenge" Nov 05 20:05:57 volumio go-librespot[18572]: time="2025-11-05T20:05:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:05:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:05:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:05:57 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:05:57 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:05:58 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:05:58 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76. Nov 05 20:06:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:00 volumio go-librespot[18582]: go-librespot daemon starting... Nov 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06:00Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06:00Z" level=debug msg="app state loaded" Nov 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06: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 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06: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 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06: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 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06:00Z" level=info msg="zeroconf server listening on port 33775" Nov 05 20:06:00 volumio go-librespot[18583]: time="2025-11-05T20:06:00Z" level=debug msg="obtained new client token: AACu0NxH7FClUdOiEDx9Dn1XoxscRf6/lQWv2+luqCFGHqQ68xHUR2sP0LnqrBhxGOIuHJ5pA+zPaJByD9LAJ2bqxbl0U95R6nRH4Au1mn4dU1LxrlHbXxw9pBsoOvdR6hFYl/05aslHTpssO72FaYzKMMl+GaMpxXuB3JUronEjOsDpfCOHMrJEspCdjcNZjH9eN0VuTVe9djagu8oaJQ70ZxPRAP/0HEzHywok5kK1BgLXY9zEXuM=" Nov 05 20:06:01 volumio go-librespot[18583]: time="2025-11-05T20:06:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:01 volumio go-librespot[18583]: time="2025-11-05T20:06:01Z" level=debug msg="completed keyexchange" Nov 05 20:06:01 volumio go-librespot[18583]: time="2025-11-05T20:06:01Z" level=debug msg="completed challenge" Nov 05 20:06:01 volumio go-librespot[18583]: time="2025-11-05T20:06:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:06:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:01 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:01 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Nov 05 20:06:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:04 volumio go-librespot[18590]: go-librespot daemon starting... Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="app state loaded" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=info msg="zeroconf server listening on port 39601" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="obtained new client token: AABSMyeDGOTd0fWD78AHChE8luzcSsF2gheQcQc76Aqgc5d3iv9/pegdq55tAFGN/rgRQOsoNHRZvgit4GCng5I2eOf93Eozdhy0T5Mjxl2P6l9MiUIIUH3n3i7B9EJJ08sRFaRwWkJzfW7lSbFtPsPD0QLlF0xIY3enRrnq0BEfGbtApyJ2Jt4bxoSWuYdDqeraanrXqPjF1yHlabjA6tc6rDXIFm7SpBv0JxPD2qTfIfIgLwva4Hw=" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="completed keyexchange" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06:04Z" level=debug msg="completed challenge" Nov 05 20:06:04 volumio go-librespot[18591]: time="2025-11-05T20:06: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 05 20:06:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:04 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:04 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:07 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:06:07 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:06:07 volumio volumio[17635]: info: Listing playlists Nov 05 20:06:07 volumio volumio[17635]: info: Listing playlists Nov 05 20:06:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78. Nov 05 20:06:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:07 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:07 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:07 volumio go-librespot[18613]: go-librespot daemon starting... Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="app state loaded" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=info msg="zeroconf server listening on port 42699" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="obtained new client token: AAA5mepzLxuuYE1oxcDQGeVnsp0EeUffQqse2ivusbizlWcR9ntmBSLeG5UA7yowzRfjUdrH1G6vK22KReixzIHTxqaGIEYEnUjOH3ih6gVS8zeW3VP7US1pTkIvTm/Yya1Ci80khFgPUI9RSacafr3BM6Wj+yEaAL8R+eX1BdofjDego3/oDLIB6KadRXsbzBTBceFbsFRNuyh04Yp0LVue/lHSIHhugkJ16pI8fh3EaYoAJaGnTvA=" Nov 05 20:06:07 volumio go-librespot[18614]: time="2025-11-05T20:06:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:08 volumio go-librespot[18614]: time="2025-11-05T20:06:08Z" level=debug msg="completed keyexchange" Nov 05 20:06:08 volumio go-librespot[18614]: time="2025-11-05T20:06:08Z" level=debug msg="completed challenge" Nov 05 20:06:08 volumio go-librespot[18614]: time="2025-11-05T20:06:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 05 20:06:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:10 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:10 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79. Nov 05 20:06:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:11 volumio go-librespot[18621]: go-librespot daemon starting... Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="app state loaded" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=info msg="zeroconf server listening on port 38365" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="obtained new client token: AAB15MKTDM5aDFlvHKxd22jA6SnG8aQG5w6ArhR/jt6/o3vfXnw+7Z6h87m4MK59Z56ibKFmd+xPtSfauQZbMWygnQ0o7iXpHD5/BLu/PLP5TkObC8ySlzJtzcqkMttvxRW/zDRMlxO7aj/FvUT10c3YrnXWdutLUasvWl3pywO55dN5wNCF+5HeE/sf2AiLhBRY0Z76ZEbyrBsAPY28krcsFmBZ4L0FeaPBZ44k8+V8bbAlAP9vFqg=" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="completed keyexchange" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06:11Z" level=debug msg="completed challenge" Nov 05 20:06:11 volumio go-librespot[18622]: time="2025-11-05T20:06: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 05 20:06:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:13 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:13 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80. Nov 05 20:06:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:14 volumio go-librespot[18643]: go-librespot daemon starting... Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=debug msg="app state loaded" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" 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 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" 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 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=info msg="zeroconf server listening on port 35425" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=debug msg="obtained new client token: AABd0mbOCIVbUV8tHhXjHEoJFHadheQQT/1byXxD/QlhL2I3n8sjB0mC9eUpEIkAw1j5yaxUIA/nzKger/YVgk33+B0GL1R1SnonNBosJ4SFGWtv0IeHA/6BiCrx6eMXSHOReXvVm2xghThd6Y6elnRVVQCbJSQp4wSZ5C6Uwqyr7vLR8PPCiZOKIY0RFJGysr+Jffe2Kvcg7rcs6B26SmgPialHG/lLdR40vn7EP23BX/bBx2uaD48=" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=debug msg="completed keyexchange" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06:14Z" level=debug msg="completed challenge" Nov 05 20:06:14 volumio go-librespot[18644]: time="2025-11-05T20:06: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 05 20:06:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:16 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:16 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:17 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:06:17 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:06:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81. Nov 05 20:06:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:18 volumio go-librespot[18651]: go-librespot daemon starting... Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="app state loaded" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=info msg="zeroconf server listening on port 39377" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="obtained new client token: AAAEZBF3W1ecV9jY2pM+O944822lY2/mudSso9vQt+0lYhQkd5cg9j22SFKyuULOoivILN4D5CLxTjUTHB8vuINW9ixBSJEb41nRs/WEq//BKdb4iLqJaxvBiKQl8uV/nFx3HW9kHelkKL9XW2AHAhV6nLIOAuXQ90h9WOf1muZLPQWxdjFZrxuyqvchcYdm0MvKqa1q6y/4n9VsByjMWcjvBI9InIo7kO2XhQ3Ss1OciqH5pyrj" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="completed keyexchange" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06:18Z" level=debug msg="completed challenge" Nov 05 20:06:18 volumio go-librespot[18652]: time="2025-11-05T20:06: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 05 20:06:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:19 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:19 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Nov 05 20:06:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:21 volumio go-librespot[18662]: go-librespot daemon starting... Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="app state loaded" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=info msg="zeroconf server listening on port 46515" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="obtained new client token: AABfgeSO+xo8JstFRkmFRupISqQbUrDVEXtYVou+MYPPgHPGqzJ3IUJj0ZT4QYZqnPNDekZV7TqPbXksvLW4+W7GpNi70cNT7ba1CScA3b8oc0Ssce8xiZuodvk/28Q/zl6hjoWAwSjf9DCrFzaPvGVP3MrnoVUX4y8CTHC88s4v1+wiXFEH19zReLddu6SG3+Aa1pCfiF/5ixk1jsAyJZjcH/Fg7RlyAmxXQDe3ZIXGSXW+n7e1KKI=" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="completed keyexchange" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06:21Z" level=debug msg="completed challenge" Nov 05 20:06:21 volumio go-librespot[18663]: time="2025-11-05T20:06: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 05 20:06:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:22 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:22 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Nov 05 20:06:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:25 volumio go-librespot[18684]: go-librespot daemon starting... Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="app state loaded" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=info msg="zeroconf server listening on port 38347" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="obtained new client token: AAB42VMZ7CJwQrFfMKhaRQLBYjjrnsVBG2+KrYt1lkiGQt2WkUksQGo4TvAFqFByAY/iMSoJ+yIKVG/cAJTnKxKEEjuZJZuXo1WCeeZeVtYIO8NujVSgS7Wlzxr8DlQ4A/ml/iCvmElOuERQl87frvONRim3GUaaS585vztvGjTjbrtpNmUWK9HKPzt4jbmlYsx9CpV5R8HOspkalzh6EB8hPP0JU3E8b/5Q9x5IoHPn+3+zL65z" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="completed keyexchange" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06:25Z" level=debug msg="completed challenge" Nov 05 20:06:25 volumio go-librespot[18685]: time="2025-11-05T20:06: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 05 20:06:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:25 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:25 volumio volumio[17635]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:27 volumio volumio[17635]: info: CoreCommandRouter::volumioGetState Nov 05 20:06:27 volumio volumio[17635]: info: CorePlayQueue::getTrack 0 Nov 05 20:06:27 volumio volumio[17635]: info: Listing playlists Nov 05 20:06:27 volumio volumio[17635]: info: Listing playlists Nov 05 20:06:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Nov 05 20:06:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 05 20:06:28 volumio go-librespot[18694]: go-librespot daemon starting... Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=info msg="running go-librespot 0.4.0" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="app state loaded" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" 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 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" 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 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=info msg="zeroconf server listening on port 42615" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="obtained new client token: AAB7DrI724TJ6oR2uV+tl2FnOskiK6QzZ/ABG7E7KbuET6u+2NmOPn0FI8Ss3RZHwo1wxWx+99fMcVnJ6yhHIg4fZ782PyEOozy3THBFNizcqIweOvMERRRVEfNRIOu90MMP7fGgzs0jjsYZYB/OYuCa/KYB9RgTG/F8Jz5RfWDFpx5fmNc0iZ4u6rExuIIcRnJmmqMOKDrvHrEidV0oC0/ByRCvO7Hj71I6khikFyIkfgpRadjkqSw=" Nov 05 20:06:28 volumio volumio[17635]: info: Initializing connection to go-librespot Websocket Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="new websocket client" Nov 05 20:06:28 volumio volumio[17635]: info: Connection to go-librespot Websocket established Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="completed keyexchange" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06:28Z" level=debug msg="completed challenge" Nov 05 20:06:28 volumio go-librespot[18695]: time="2025-11-05T20:06: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 05 20:06:28 volumio volumio[17635]: info: Connection to go-librespot Websocket closed Nov 05 20:06:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 05 20:06:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 05 20:06:31 volumio volumio[17635]: info: Getting Spotify volume Nov 05 20:06:31 volumio volumio[17635]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 20:06:31 volumio volumio[17635]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 05 20:06:31 volumio volumio[17635]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 05 20:06:31 volumio volumio[17635]: errno: -111, Nov 05 20:06:31 volumio volumio[17635]: code: 'ECONNREFUSED', Nov 05 20:06:31 volumio volumio[17635]: syscall: 'connect', Nov 05 20:06:31 volumio volumio[17635]: address: '127.0.0.1', Nov 05 20:06:31 volumio volumio[17635]: port: 9879, Nov 05 20:06:31 volumio volumio[17635]: response: undefined Nov 05 20:06:31 volumio volumio[17635]: } Nov 05 20:06:31 volumio volumio[17635]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 20:06:31 volumio sudo[18717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-05 20:05' Nov 05 20:06:31 volumio sudo[18717]: 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"