Oct 12 23:33:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 421. Oct 12 23:33:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:01 bcik go-librespot[3628]: go-librespot daemon starting... Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="app state loaded" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=info msg="zeroconf server listening on port 37579" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="obtained new client token: AAFAVrZWH7Hzik0Iun/TwvAjGE1OYG8T+13lkH1wooVp6SUfmQ8624BH82N7WYW7wGOLy+uU9oVo463lwjZSGJL61sXE0afEuI7meBJD+rOw5ZuMo12qoG0907zR7+35p7Nv4m9xxJACLAXfIlJcXjMQk46g3auHdwuUPtFb1oMbS1aiPCoy0rFVQB1PH8yCFoQL+LBcbw3PsmE5Cl6TUPPnfuSF96c4Q1qtnmKBpkxcU+HGsobWqVQ=" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=debug msg="completed challenge" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:01 bcik go-librespot[3629]: time="2026-10-12T23:33:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:02 bcik volumio[3307]: info: MYVOLUMIO: Adding device Oct 12 23:33:02 bcik volumio[3307]: info: MYVOLUMIO: Evaluating Server Oct 12 23:33:02 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:02 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:02 bcik volumio[3307]: info: Setting Geolocation for MyVolumio to eu6 Oct 12 23:33:02 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:02 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:02 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:03 bcik volumio[3307]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 23:33:03 bcik volumio[3307]: info: Updating MyVolumio device info Oct 12 23:33:03 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:03 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:03 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:03 bcik volumio[3307]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 23:33:05 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 422. Oct 12 23:33:05 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:05 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:05 bcik go-librespot[3657]: go-librespot daemon starting... Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="app state loaded" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=info msg="zeroconf server listening on port 34785" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="obtained new client token: AAFqR/DB2jl2X2yLjUhrfn/cX8QgaGeUBKWWcQkVqcMpjkaCnjYt7TOlb5X+M4qV0NOSBtpMxodbwA5X54gTBfDrSa2ymC9vipXR8YiZ0loS+EZ1USPgOFAp4ddSPd3ViCqJCYhuPHKwGa9YzkqBDfRMp1RTW9W/NyspXOrkECWCWenSgjm7i5NW9MwrlWQsabI3Tn3P4MSfPdt30A+obu0bopZRcUOtwhFSu0UZvnc0wAo22G2R" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=debug msg="completed challenge" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:05 bcik go-librespot[3658]: time="2026-10-12T23:33:05+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:05 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:05 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:05 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:05 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:08 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:08 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 423. Oct 12 23:33:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:08 bcik go-librespot[3681]: go-librespot daemon starting... Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="app state loaded" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=info msg="zeroconf server listening on port 41851" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="obtained new client token: AAGZthJzHgf93YEkSkzze4e+RM3j0grZ9NM8NlHWbdPj5eXOipOnG+7aTHT8Hop9u/0vLo0So+rN5l8XPXZXj6IQceZsKYeQVtnpVcRRxoqz1yal6gtODLboEUJBYnkCRr7pnSNr2oSyy3/OgKjJvzctZCgPOZ+qr5b/zCG0U+Z3Wc8CtZb0oTyRGzP+7MSzJzI9IhK8+V1j0K2bIm48PhQsh2QFwEAIPtpB96tz8bndmokp1feyf3Y=" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=debug msg="completed challenge" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:08 bcik go-librespot[3682]: time="2026-10-12T23:33:08+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:11 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 23:33:11 bcik volumio[3307]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 12 23:33:11 bcik volumio[3307]: info: CoreCommandRouter::volumioGetState Oct 12 23:33:11 bcik volumio[3307]: info: CorePlayQueue::getTrack 0 Oct 12 23:33:11 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:11 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:12 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 424. Oct 12 23:33:12 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:12 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:12 bcik go-librespot[3692]: go-librespot daemon starting... Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="app state loaded" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=info msg="zeroconf server listening on port 33653" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="obtained new client token: AAEiyPwLekc/5KwcFW0GzLAg/GXoXXFNfJAFela6bnhF0xhqdWGlmXsCFhiq3o9c6j4H4YQPYUcBs0EBLnaqUR9dAf856VsGhNgb5CvxHbMnlh6dmSEjBRN0EA6SzNhUCqLEpk/xonypf6BjtRsp/7OkKkOWzciyHAnpNdY2EwFpR5mcj9S5zJbe1RrGdi2Hpwg7Rk2EejxSCDKEfJG1VFL1pIq3LTL7H9GbphtxkvnTTX8Q5T+R" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=debug msg="completed challenge" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:12 bcik go-librespot[3693]: time="2026-10-12T23:33:12+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:12 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:12 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:14 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:14 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:15 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 425. Oct 12 23:33:15 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:15 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:15 bcik go-librespot[3702]: go-librespot daemon starting... Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="app state loaded" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=info msg="zeroconf server listening on port 45851" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="obtained new client token: AAE3xTehyFw48oBWdeQwXj/lhnPknONKnzsAF9ngamocnx314kDEaifhsj3jDx8Jgq7IUtjbZFVNhA0X570LJIOUa8YDHEnpdn1uSjDHwK7+aW+NERWX+MDcm5h1RMCF7+cjSLZKiUaKP3EtxwVfmulyT5OD1Kbm8UzjZwJRnx94R9sZJQ8I0JeHbi4i/1d2aFPi1xMJGkc2qdS5+McWmXT9znQCwWBdMGP/PT4Y66Xv+iNX0+pLAb0=" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=debug msg="completed challenge" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:15 bcik go-librespot[3703]: time="2026-10-12T23:33:15+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:15 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:15 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 23:33:16 bcik volumio[3307]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 12 23:33:16 bcik volumio[3307]: info: Completed starting MyVolumio Plugin Oct 12 23:33:16 bcik volumio[3307]: [Metrics] CommandRouter: 30s 645.25ms Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::volumiosetStartupVolume Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::Close All Modals sent Oct 12 23:33:16 bcik volumio[3307]: info: CoreCommandRouter::Close All Modals sent Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 23:33:17 bcik volumio-remote-updater[9031]: Test mode disabled Oct 12 23:33:17 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 12 23:33:17 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 23:33:17 bcik volumio[3307]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 23:33:17 bcik volumio[3307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 23:33:17 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:17 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:19 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 426. Oct 12 23:33:19 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:19 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:19 bcik go-librespot[3732]: go-librespot daemon starting... Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="app state loaded" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=info msg="zeroconf server listening on port 39727" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="obtained new client token: AAHNQt/BuT8EJPfE5RAnHuf8oToTfqr+mO4Gr6oAW/LnpCN5Zpbkupel/ZkR59+p/wDW4DWGlDQQdnHeI6+gBwjKJbx5qTS9nrnKm4OAqFnwcB2Sg6bOphjXG2a5rIEn0cMtgnZ0iPiW9FF8G67yutwq2M9vgR3DSjdDGwI705isWl/p+O++WtipIAdTl8/XGxPoFCDgdsVU0YrSe6kLNDGBnc0BPBrYlth4nNjAh9YwWSJJ4Ft3" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=debug msg="completed challenge" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:19 bcik go-librespot[3733]: time="2026-10-12T23:33:19+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:19 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:19 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:20 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:20 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:22 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 427. Oct 12 23:33:22 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:22 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:22 bcik go-librespot[3742]: go-librespot daemon starting... Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="app state loaded" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=info msg="zeroconf server listening on port 43871" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="obtained new client token: AAEAaluG7NBRZIiALT1sSQRFhRa570FKpjgZRggmxI8JAmx1yEukulX7oyd2fuVl0PlIC3bemAhEHWRIeWvUQZ6pQrn67wkhrpQ2dHWantBgvEXH8yvYX1W1H9IV0YT68Hx2jsr04Y8C0pfOHRTBg8UvW7yT2n97lEskN6FRPspZ1dk+g89OMyxnu3A3cBPE4x5Sge0+L5GeDxOPm2PdOE40dfmvcBfANEtgBdPRgM4k7zGgICmEnGA=" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=debug msg="completed challenge" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:22 bcik go-librespot[3743]: time="2026-10-12T23:33:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:22 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:22 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:23 bcik volumio[3307]: info: BOOT COMPLETED Oct 12 23:33:23 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:23 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:26 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 428. Oct 12 23:33:26 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:26 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:26 bcik go-librespot[3753]: go-librespot daemon starting... Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="app state loaded" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=info msg="zeroconf server listening on port 33385" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="obtained new client token: AAFbaU/wYJ6TzSC16bwTzWuD/JltbXDQ7PVWUPbwOuZEkPWeYXWgmYTnSH6ecKRPE9X3u94GKYGKt7U51Ykd07bqqvoAqavbzv4t08x8BN42ofGPQsmglF+cYTEBVv19+CaKjzMqyYJP4gax55l5JyVVf+zBfCcM+EeRgTi5D13JEGtzUI80fM5y7/u058fWH6epDln9Zz/UFrxA8D+qa4CCIWVNASwq85Nm8dCHQDLkpZDy66Q2" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=debug msg="completed challenge" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:26 bcik go-librespot[3754]: time="2026-10-12T23:33:26+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:26 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:26 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:26 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:26 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:29 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:29 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 429. Oct 12 23:33:29 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:29 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:29 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:29 bcik go-librespot[3777]: go-librespot daemon starting... Oct 12 23:33:29 bcik systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="app state loaded" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=info msg="zeroconf server listening on port 38623" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="obtained new client token: AAH4c5mXfIu5txIJ6H1MN7I7WbggJXNUqLtwSCLKXyIi7gr989hQFyFghkrW+yV3uPf+NvnBti3eN29dtRV7VV3y76WUaNNjMUgSnYu+ABHSPW/DcFAmpf+eXWyvcHFDKjwWy9Kg4rQ7TJiR0EmWBX7PmtBS12L5EGDkfnEEUgzxHdjn+b4MGoHnfAzYVd5JCzwdtS1c3BSBKPNpyd24Q0bzueBzznk8XYSVWmBCThC5MJgj7w/Pcjg=" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=debug msg="completed challenge" Oct 12 23:33:29 bcik systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 12 23:33:29 bcik systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:29 bcik go-librespot[3778]: time="2026-10-12T23:33:29+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:29 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:29 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:32 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:32 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:33 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 430. Oct 12 23:33:33 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:33 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:33 bcik go-librespot[3813]: go-librespot daemon starting... Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="app state loaded" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=info msg="zeroconf server listening on port 42203" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="obtained new client token: AAFNxhy5LliBFwR5eUwT3n+ODKJJMRA4sNKn29v5VqO2gYM1NHYaZO/cD1NCDSSnU8oaqhB7IAMiNrP9mXR0hRxPbm2VhdR9k1f4OvDGNYojhB3RmqtW3NfysWi58FmWl0tgiEHT3OfdortvN5Rmmz+gE05FLmeFh97u58OASNwjRJCjhVx5OrbtWD8ui6S9T8/Z4/vCfp/5GHBYqZfWC6Rb5TUUKkE4qtaPhRBq9pV/8jfasQCu" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=debug msg="completed challenge" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:33 bcik go-librespot[3814]: time="2026-10-12T23:33:33+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:33 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:33 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:35 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:35 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:36 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 431. Oct 12 23:33:36 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:36 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:36 bcik go-librespot[3837]: go-librespot daemon starting... Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="app state loaded" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=info msg="zeroconf server listening on port 32905" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="obtained new client token: AAH5agRztyM+LDRkdi1f00RR4GJQ2YkCF3DRPFpNHx8XkCcovnCoIcOjGjfsPgQP0BssmJPlb4c5TdIeowypnn4OwCvquQkIbaxIWI0NPceP6zUJCV1MOa0q41zQ0iqVXnzwa0GDM8G25b20I914CNZEQT00VuQYIjKCfPssjhls3fPJVHb6wSmnD3llvpAIS/x+gAt0gbqHh0vCYyNRMI0sK95/RscQ2WE6q8soKI8HIIoI2KUi/Qc=" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=debug msg="completed challenge" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:36 bcik go-librespot[3838]: time="2026-10-12T23:33:36+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:36 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:36 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:38 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:38 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:40 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 432. Oct 12 23:33:40 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:40 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:40 bcik go-librespot[3847]: go-librespot daemon starting... Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="app state loaded" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=info msg="zeroconf server listening on port 40941" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="obtained new client token: AAGG2Ft4Cw/z5rkWQf9AxOXRM9T+ZhjSNj/bqqbG9+rGQvSxh9G3B95srgkkW8YFsojtF36PJOXta8lxarLlKfDvwTSsX9VRWHRWMajIcyIwPQGLvsWYEbTOCtSFtldigdb8fWUtlPULZCvuilXIgHfZYYDxhDbZ5qsde6nStb7y8AXZsAgobly/O7Au9v4AWhgHdBMQwnO/xwO0G0y+YznoqdF8I4RkXyl2yBg7w+DAV9wCMa1L" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=debug msg="completed challenge" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:40 bcik go-librespot[3848]: time="2026-10-12T23:33:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:40 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:40 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:41 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:41 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:43 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 433. Oct 12 23:33:43 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:43 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:43 bcik go-librespot[3857]: go-librespot daemon starting... Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="app state loaded" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=info msg="zeroconf server listening on port 42009" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="obtained new client token: AAHAKhKH7ZlTOIAlQNK4J5A3yzBTYDVK+ASaSVeGozUbZb0KN1H1/Y3giqNtpXCp7Zjl6anpw/ohHMiIjUcWsETQZtdS1WZNf5ehZ5NX6yKrsElodjvxKt+e/wKQNHeRyRZeL42UuQvBnWMqOkfV9FwqaHkJHoEuihP5K/59WmrnjY/GTz3RW5FkvgnKyzP38qWf0JXQDX92/mh9BUmU2J5nx7a8t7L5JR+0HF3tFnTVzhSKIQ/CXEg=" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=debug msg="completed challenge" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:43 bcik go-librespot[3858]: time="2026-10-12T23:33:43+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:43 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:43 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:44 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:44 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:47 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 434. Oct 12 23:33:47 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:47 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:47 bcik go-librespot[3882]: go-librespot daemon starting... Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="app state loaded" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=info msg="zeroconf server listening on port 37689" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="obtained new client token: AAFsda/SN022hGDEoIyNALDrYfyiK3m84RVCZxMfqUJwu+P2RKghUfX1fco5X+6Xcnl+XPB7yaxf4KC+n/sn9mwFAKyy5xtLkst5Q32LootQTR5wYj3Oya0me9M/BmMoqOpOjrBEZYet/IVf6zEoExUTj3DcBFNcJ7wXaug8LDdu4/Cmmzym1BPIjr+1ae3l9QHXgsr/JSAkZbwbKzXdlb3E5rHdR/NdJU9AnhCJ0ONAWwVTMcdc" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=debug msg="completed challenge" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:47 bcik go-librespot[3883]: time="2026-10-12T23:33:47+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:47 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:47 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:47 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:47 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:50 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:50 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:50 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 435. Oct 12 23:33:50 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:50 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:50 bcik go-librespot[3892]: go-librespot daemon starting... Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="app state loaded" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=info msg="zeroconf server listening on port 34835" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="obtained new client token: AAEN4o1AKpeGE2MkUBl/7mCXRHpNGoS29aoOoiqWKRY9Hs4MsFpPC57rpcnu91C4MZBN8FzQR9DpmATwdMtwA/3AX/hXQFqByFL/2NpVPGolpvPSt2VICoH5jt60xUqkw3Uxu/iKPAL1cTt8q3NPvrMTstkl3bsENo1Yh+FIZbrftNSvTV9IIskmtWqE2B/SGnMu6fefxyAM/xibwpbOwU2W+oXq1I7ingQ+MqeCWuzbW4Qy1a3u8ow=" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=debug msg="completed challenge" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:50 bcik go-librespot[3893]: time="2026-10-12T23:33:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:50 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:50 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:53 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:53 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:54 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 436. Oct 12 23:33:54 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:54 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:54 bcik go-librespot[3902]: go-librespot daemon starting... Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="app state loaded" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=info msg="zeroconf server listening on port 39773" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="obtained new client token: AAEJarIULLvnfiPa66EGkie50MspEGjHHuJj6nc0yobmB6biokeCeqR84Nl9lo9he1r9TYghhy5+0p3eVhvZQHwasiXDMeMN8qrENEtkyddwznNB9l7L7ynSI6WIWsr/2mC3ELiP1AMLJoq/SVcnzz2FSg6wQCrfzyENAdrxmMs9FARv5t34sz/NmA3xJ0f0yR2hGrTD+c5UdCzSA69wTG3mSeaQnutBDIZEchMUYIJDHkCj6n/x" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=debug msg="completed challenge" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:54 bcik go-librespot[3903]: time="2026-10-12T23:33:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:54 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:54 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:56 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:56 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:33:57 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 437. Oct 12 23:33:57 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:57 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:33:57 bcik go-librespot[3926]: go-librespot daemon starting... Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="app state loaded" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=info msg="zeroconf server listening on port 37691" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="obtained new client token: AAFSuyh4udwJ5ROxQ22erlXszou152u/r/2x6YrAcfmMjuPvdRmpDAXfu6rKYWHhJh6ifTNin8ZWf7QKZBZaPCWk2I/+ZTwMxJ/vrEL4b5sG/B09v45j7RRLwHzWE2Oq2Mmiwys4s3meooUeNJNls3Gm0LxLSkogS+vp0AjEf8c8O2nJHUgW/RCTEQVqEHvNTo0RXoGhwRbGvYKKZRc0cyW6nNWStoeHEnvi66cBjFyLnvKNPJPsbA4=" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="completed keyexchange" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=debug msg="completed challenge" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:33:57 bcik go-librespot[3927]: time="2026-10-12T23:33:57+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:33:57 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:33:57 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:33:59 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:33:59 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 438. Oct 12 23:34:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:01 bcik go-librespot[3936]: go-librespot daemon starting... Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="app state loaded" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=info msg="zeroconf server listening on port 35937" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="obtained new client token: AAGaD/mCnn0rtMUyTt9CoWj+skKY3yzH3b9llJrE2WlhgYpMzzgNmUG4Cy2xtIz3JcxucHZ0gH1TdK0snutkaDfVB+KQtiQjVESqy7kB8H/GPVVeIhHmWATMqMwP8i5gixfWjWTPdTBNJpZrpR+dWCJoZ8IWEhOoVum9m/XNqS/IU2LUyXn+2qSN36YJIoz9GSiPaYqMPjOO55zeSw9xHpQ31dHMKEy/xOyexzOTwfBinHKJZxYA" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=debug msg="completed challenge" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:01 bcik go-librespot[3937]: time="2026-10-12T23:34:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:02 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:02 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:04 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 439. Oct 12 23:34:04 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:04 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:04 bcik go-librespot[3946]: go-librespot daemon starting... Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="app state loaded" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=info msg="zeroconf server listening on port 33507" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="obtained new client token: AAFL3rqnuG3D/SFBUGWWnf9XSumGweq4p+mFLT9Zw+fX9EXMbEuDBAj/1WaQ64RILy9K2e0QPCg+YJnUOWk7EhjsnCqtDhOQvBKVquwTo7u6ejE2G0pbU3ZNfOG23P2Qu4VvlP8VGMUljfId/Y54eZKCp312VXJThfRhx1PYcpi3uvaMsC+KJfusaLwgZXcAfQlM2s7lw8bOb4iyL6Cnr9f6W9WrzOVtC7mn1j/ig5uF3vWvhbsJDUk=" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=debug msg="completed challenge" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:04 bcik go-librespot[3947]: time="2026-10-12T23:34:04+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:04 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:04 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:05 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:05 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 440. Oct 12 23:34:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:08 bcik go-librespot[3971]: go-librespot daemon starting... Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="app state loaded" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=info msg="zeroconf server listening on port 45257" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="obtained new client token: AAGVT6ULipdzvQHQUC4aUZLT0hjRu/1zZFigAiIQvms/Djq7aMJA/5Oh4lt7vtjU6A3TkoLJ/Fiop1YxCGJ9tV3JqHSOjq8CW2YEJqqbrxfeUhw/yTBfVDql5//NYS3XVBwg4EDSi3g6QvF/HPLxHGnnvRdPK5Fmo1whrG5RPsg3mjzNxDlEFVHJzRctblPfpx6E9iIoQKfxBQXFFIKkCV/4iZtNhBAacwbkU30ri0oyeBlpAyXH" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=debug msg="completed challenge" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:08 bcik go-librespot[3972]: time="2026-10-12T23:34:08+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:08 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:08 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:11 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 441. Oct 12 23:34:11 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:11 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:11 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:11 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:11 bcik go-librespot[3981]: go-librespot daemon starting... Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="app state loaded" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=info msg="zeroconf server listening on port 44209" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="obtained new client token: AAH2MnwoPzG2vznAb0caUYKsf38MZ37mZly/F7n/uHGPOchvSi7IyFZcmg5ZkFtbnM3k/LsWsXKsNc8aFzSVVIzvI4fZ6whJ5wlRXJJbFErwQd1sN/dsmpnS9r4/Zh64mOHE4Nk5jTliWAniRZepuKe7yGTQ1CFlFJL2k9/vEo+jKOtFL+p8VbcfnkCLUA6twBmnr2PtY6HtjlEMoiMMteqcYLFSOQRGgAduqOrws7OOstxQlzq/jqQ=" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=debug msg="completed challenge" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:11 bcik go-librespot[3982]: time="2026-10-12T23:34:11+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:11 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:11 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:14 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:14 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:15 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 442. Oct 12 23:34:15 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:15 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:15 bcik go-librespot[3991]: go-librespot daemon starting... Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="app state loaded" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=info msg="zeroconf server listening on port 35779" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="obtained new client token: AAHAr+xgbd7r17eGnhbJS9Q4IU4uxo8VoO99wohyaSx3mXllKyVQNZ6D/QCVf7VcTwrK64q+iXlSw+/UtJCqTdOOjPDKy+OAe4ZswAz0wdbMv6h/hIdfyyxFMV5ZuytO/5QcQ1KVH0n0ZyTXw/iyDc7nU79Ur1zLrQm2FG4/UKICkxUa4rGYhYolWxNRpGZrnt13974STrYD2LUFLl9exz1oC2AhEiDfsSO8P3/ToLLlYlJbREBn" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=debug msg="completed challenge" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:15 bcik go-librespot[3992]: time="2026-10-12T23:34:15+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:15 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:15 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:17 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:17 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:18 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 443. Oct 12 23:34:18 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:18 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:18 bcik go-librespot[4015]: go-librespot daemon starting... Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="app state loaded" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=info msg="zeroconf server listening on port 43391" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="obtained new client token: AAEaTuJph3YgdcCuarEE8KubqHHyDhe4/MjawfONTorZvoYhyVsbVHKIEdkZ48METxZvns7XJhXcnrmOF1Aoe4KKYsdueK3WGxNGmSF6raJD9MJNz+vxXIcjA4/OW9XMIUaD2pi7ZvY0mL51ahFW5QB0amRKHopi0mFV4MGeiWT3QdACIZtqBN2vLw5jvsSxiYsMtGj8/Yez2pPA4/rF0u4qjC/GyiKGyxKQSKW/eruQ0OZhlFQobvM=" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=debug msg="completed challenge" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:18 bcik go-librespot[4016]: time="2026-10-12T23:34:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:18 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:18 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:20 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:20 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:22 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 444. Oct 12 23:34:22 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:22 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:22 bcik go-librespot[4025]: go-librespot daemon starting... Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="app state loaded" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=info msg="zeroconf server listening on port 38139" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="obtained new client token: AAHS8bI73CI0qfeCBNrrjdHVattBNetxM4n5+aWHXrvorq1qI/1dGbtiOfw9UvC5SxCcJDcwdbpvbpKRLsBioO+ZgRJnaSpO14FWOAIH4FHAmrORIYGqc4iqU+TNOu7/jiCMWPS+13h4qJ9Lf2eQzkNTrSMyDXz5mik8tZwvxLns7RItNzLoOGpagJsCc4xdnFEvxRvw/Pv2+wT193kwvwCc1tvUubxfOiWwcXDKXxJr8N1yCGHB" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=debug msg="completed challenge" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:22 bcik go-librespot[4026]: time="2026-10-12T23:34:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:22 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:22 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:23 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:23 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:25 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 445. Oct 12 23:34:25 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:25 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:25 bcik go-librespot[4035]: go-librespot daemon starting... Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="app state loaded" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=info msg="zeroconf server listening on port 43153" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="obtained new client token: AAHvLu/N570jAmSVmqcaHvp6J5AwXvhuALwAaTEd6KY9b3hm0Qow2ppW129pxB/wQV4Qd9eZ7YJy5GBvFaWbQdaZn6Gv8JTjpE0jRmfydK/sZT0Izi+T5i2AL8UrYjidTe6P9w2W+cy9cIK1iht1q25uAX1hRLtbgdnIC+VDIuLJ3c8N53cBCL7zHeTvF/nmHrYModBnOQCcQqY98Crq5lRNfTFu9nHW+E36d3jVAkA/fo6mFZYbwJw=" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=debug msg="completed challenge" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:25 bcik go-librespot[4036]: time="2026-10-12T23:34:25+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:25 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:25 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:26 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:26 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:29 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 446. Oct 12 23:34:29 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:29 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:29 bcik go-librespot[4060]: go-librespot daemon starting... Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="app state loaded" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=info msg="zeroconf server listening on port 33035" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="obtained new client token: AAE6bG3uNhK5RrYkIUYRskKLqnbek3Z2f1STFmZO/Nt5vnOTN+CRDesuooERSrTyTCTisBCjr9ca2OLj6BKWOVNwPVKHW8Iv1f5ouUdRaK3XPAUjKbZy8YU60sz8NQyzbVeo5Wy2MAHQTyEnY+UkuHmmCmDl99chg+3IcMYRn9ZaPSyAfbmpeFmxm2xBG+V1PO1vac1QhXNmNEiOvGqQHJqAsUKWRxO/vr4dY1uJLdOCcOT7ihuj" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=debug msg="completed challenge" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:29 bcik go-librespot[4061]: time="2026-10-12T23:34:29+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:29 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:29 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:29 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:29 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:32 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 447. Oct 12 23:34:32 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:32 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:32 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:32 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:32 bcik go-librespot[4070]: go-librespot daemon starting... Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="app state loaded" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=info msg="zeroconf server listening on port 33845" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="obtained new client token: AAGLuUIQTU4gitcpXuLhZ08yI/CP2wubaSm+FiOnPJHVBUVZEQSQRfFOM8VndqOty3mMM51vMlcImH/G8SK8cN8BHGKrHWsdhRiZo15IBbMOZInIE6NFACTpmWiaStlwLbufAs+abEkM86qxllRQBOTmbeTQy8RUI07EpPnfv1zE/iH+67xP6clzbN2SWHaH4QgMav9kQtjDGOjHmqWXzt8thv6/M33oxBg6UEx4DuB0ACYVzBDgK+8=" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=debug msg="completed challenge" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:32 bcik go-librespot[4071]: time="2026-10-12T23:34:32+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:32 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:32 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:35 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:35 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:36 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 448. Oct 12 23:34:36 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:36 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:36 bcik go-librespot[4081]: go-librespot daemon starting... Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="app state loaded" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=info msg="zeroconf server listening on port 43467" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="obtained new client token: AAGOvLFRtkSSNV0KupfVNSAhqnBUqXznkre/70jIZ+rang004JSGc3yO+nApevPV4HBI5wkBT8HTzK9vhr2KKqri+Kr6N8wTHmqUd1gimBBPCcgrsXl6QiU13N70gyuxrc52f8wnG0c3MymhssxJek8+mujsmwx1gVSXhMrJ/XxVNl5L5U4wXTP8SAMkaEa1rpaEwCZYpaCzH46Ng3ER3MAmXI33x8mB8oUmfMoJs7gEKQqg/zM8" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=debug msg="completed challenge" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:36 bcik go-librespot[4082]: time="2026-10-12T23:34:36+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:36 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:36 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:38 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:38 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:39 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 449. Oct 12 23:34:39 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:39 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:39 bcik go-librespot[4105]: go-librespot daemon starting... Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="app state loaded" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=info msg="zeroconf server listening on port 35547" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="obtained new client token: AAHjQPWfW4WkykLbA1L1jvRrZcJnCl8yjsN2gyUjjKZjyCVtJmyuxhRFQvVvxLRk+A4OYef6SXuG8o+f7RQjDsNYP0+5Zzqlf+MEQQQIW/dhVa+ofJiAWPKtCFFmdS9URAQ/3a7FitUIFRkHen+UmJ7rsJFHpbBR4YJRRVhbaGfeJvRcdlLW1PnphGfwgUC42JHdbivmty3VVRFQGKfsQWnzGOzo5fefwHbqgaq5zWEQ8S27ClxOnLE=" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=debug msg="completed challenge" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:39 bcik go-librespot[4106]: time="2026-10-12T23:34:39+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:39 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:39 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:41 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:41 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:43 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 450. Oct 12 23:34:43 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:43 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:43 bcik go-librespot[4115]: go-librespot daemon starting... Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="app state loaded" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=info msg="zeroconf server listening on port 35097" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="obtained new client token: AAHFBTSnkj0zOr3YZ+jpSPHvI/+BehKKU0yhKnv6kultdPUBaZzIAABnTK28mcECRh16e4r7qilKkwidO5kKQb8jq0PveeCZ92g21eL2BlozNIop5rv8klmeD9CEyKdSSt9vQURMaYM0BJel20blNYYhU0Jpm+Iky+oBAIA9myb6voSGZ+HLTkbJ763wtSVXi5bRchh6/fniE7nmlcigBJcFKi7hwDTq9QTsmHpu90pRyatUdS/p" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=debug msg="completed challenge" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:43 bcik go-librespot[4116]: time="2026-10-12T23:34:43+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:43 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:43 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:44 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:44 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:46 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 451. Oct 12 23:34:46 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:46 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:46 bcik go-librespot[4140]: go-librespot daemon starting... Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="app state loaded" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=info msg="zeroconf server listening on port 43779" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="obtained new client token: AAEo8Xauwm9/3hGwuveqZGXeLciuNU+E+TbCEMh7Mkt2e5nNrvjgC/WIX3c1YoJ2rpmkh2r8bQ4ZMhsnuOeqzdwrdql5jW0/n2UeN33f8QGXVo1qc5sViYiSQ8qwavD/BCy4wzMdkrqW6HZuTRm15oEk1T5+4Pf4jsby2/IxS5xdmftGlrloe0DRWZgLX9kOSsQ54K+n3KKat5KjozC8o9KXrtc5qRU50ic9KBStovV1HaOxidkhGiQ=" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="completed keyexchange" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=debug msg="completed challenge" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 23:34:46 bcik go-librespot[4141]: time="2026-10-12T23:34:46+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 23:34:46 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:46 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:47 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:47 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:50 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 452. Oct 12 23:34:50 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:50 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:50 bcik go-librespot[4150]: go-librespot daemon starting... Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=debug msg="app state loaded" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=info msg="zeroconf server listening on port 35903" Oct 12 23:34:50 bcik go-librespot[4151]: time="2026-10-12T23:34:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: invalid status code from clienttoken: 503" Oct 12 23:34:50 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:50 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:50 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:50 bcik volumio[3307]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 23:34:53 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 453. Oct 12 23:34:53 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:53 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 23:34:53 bcik go-librespot[4160]: go-librespot daemon starting... Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=debug msg="app state loaded" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=info msg="zeroconf server listening on port 45793" Oct 12 23:34:53 bcik volumio[3307]: info: Initializing connection to go-librespot Websocket Oct 12 23:34:53 bcik go-librespot[4161]: time="2026-10-12T23:34:53+02:00" level=debug msg="new websocket client" Oct 12 23:34:53 bcik volumio[3307]: info: Connection to go-librespot Websocket established Oct 12 23:34:56 bcik volumio[3307]: info: Getting Spotify volume Oct 12 23:34:56 bcik volumio[3307]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 12 23:34:56 bcik volumio[3307]: info: CoreCommandRouter::volumioGetState Oct 12 23:34:56 bcik volumio[3307]: info: CorePlayQueue::getTrack 0 Oct 12 23:34:56 bcik volumio[3307]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Oct 12 23:34:56 bcik volumio[3307]: SPOTIFY: SPOTIFY VOLUME undefined Oct 12 23:34:56 bcik volumio[3307]: SPOTIFY: VOLUMIO VOLUME 41 Oct 12 23:34:56 bcik volumio[3307]: info: Aligning Spotify Volume to Volumio Volume Oct 12 23:34:56 bcik volumio[3307]: info: CoreCommandRouter::volumioGetState Oct 12 23:34:56 bcik volumio[3307]: info: CorePlayQueue::getTrack 0 Oct 12 23:34:56 bcik volumio[3307]: info: Setting Spotify Volume from Volumio: 41 Oct 12 23:34:58 bcik volumio[3307]: SPOTIFY: SETTING SPOTIFY VOLUME 41 Oct 12 23:34:58 bcik volumio[3307]: info: Sending Spotify command with payload to local API: /player/volume Oct 12 23:34:58 bcik go-librespot[4161]: time="2026-10-12T23:34:58+02:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: invalid status code from clienttoken: 504" Oct 12 23:34:58 bcik volumio[3307]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Oct 12 23:34:58 bcik volumio[3307]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 23:34:58 bcik volumio[3307]: Error: socket hang up Oct 12 23:34:58 bcik volumio[3307]: at connResetException (node:internal/errors:720:14) Oct 12 23:34:58 bcik volumio[3307]: at Socket.socketOnEnd (node:_http_client:519:23) Oct 12 23:34:58 bcik volumio[3307]: at Socket.emit (node:events:526:35) Oct 12 23:34:58 bcik volumio[3307]: at endReadableNT (node:internal/streams/readable:1376:12) Oct 12 23:34:58 bcik volumio[3307]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Oct 12 23:34:58 bcik volumio[3307]: code: 'ECONNRESET', Oct 12 23:34:58 bcik volumio[3307]: response: undefined Oct 12 23:34:58 bcik volumio[3307]: } Oct 12 23:34:58 bcik volumio[3307]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 23:34:58 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 23:34:58 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 23:34:58 bcik sudo[4198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 23:33' Oct 12 23:34:58 bcik sudo[4198]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"