Oct 13 22:12:00 bcik volumio[6643]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 13 22:12:00 bcik volumio[6643]: info: Updating MyVolumio device info Oct 13 22:12:00 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 22:12:00 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 22:12:00 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 22:12:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1878. Oct 13 22:12:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:01 bcik volumio[6643]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 13 22:12:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:01 bcik go-librespot[7002]: go-librespot daemon starting... Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=debug msg="app state loaded" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12: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-gew1.spotify.com:80]" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+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 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+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 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=info msg="zeroconf server listening on port 46871" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=debug msg="obtained new client token: AAFlaTeB2EdQz0jybJdUEZIL7gELqD5apMmJeEWr5D4hd+sbbg3yEovRInz4z7C7Cq+KDWjbfIv9Qb4sq7ju3WXWDV9lS8tl1DX9IvbebfOZCMTzjroHekvXAvaUqfCO+QWeIF1qca5GqX+/MFLjd7k4Qr74x9K5eGjUD5A3DSDMTXOvVy/ZhlKBA9xJsLVuYNoMsmPPCtzEZ52Bqnk8yAIoygFA+sPqW5HnVB4QJYBtnMXWxhc2Qts=" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+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 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=debug msg="completed challenge" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:01 bcik go-librespot[7003]: time="2026-10-13T22:12: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 13 22:12:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:02 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:02 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:05 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:05 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:05 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1879. Oct 13 22:12:05 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:05 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:05 bcik go-librespot[7026]: go-librespot daemon starting... Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=debug msg="app state loaded" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12: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-gae2.spotify.com:80]" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+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 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+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 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=info msg="zeroconf server listening on port 35013" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=debug msg="obtained new client token: AAHOu46egTw4vTKqyYQb+ox9BXI6dgFvFJAdhiXO5XeJVRJQlEijcXJAQZPz2CXib2YoNxrno3CoR4nFZH5Q5PumR2X2ZMemAQsQjCbm0sBGDN4JqJhzIaIT8uC8L4r3WgdNSgU3UsojXeAEfpfcSb5DrCpupoXo6OwkhUeXGXjsUXbkmjSkkTeRd953s3n/JO92Fs1FGoiX0c38JZ4ZcxYnzqhuAgze3L8n7lb1VyJK50BASZ1X" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+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 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=debug msg="completed challenge" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12:05+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:05 bcik go-librespot[7027]: time="2026-10-13T22:12: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 13 22:12:05 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:05 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:08 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:08 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1880. Oct 13 22:12:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:08 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 22:12:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:08 bcik go-librespot[7036]: go-librespot daemon starting... Oct 13 22:12:08 bcik volumio[6643]: 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 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=debug msg="app state loaded" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:08 bcik volumio[6643]: info: CoreCommandRouter::volumioGetState Oct 13 22:12:08 bcik volumio[6643]: info: CorePlayQueue::getTrack 0 Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+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 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+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 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=info msg="zeroconf server listening on port 36567" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=debug msg="obtained new client token: AAHGHYK0x96nN3dlKIKkaFfgQ23GzsgaI+8FYP7WTl6v3y8UT7h0BgT8L3q0/6Tc9sXxzA5sTZHs9XMXo1N+vIDpzZgw28+dfWsWdx7h0UvywKKz5FS15K1oRGhYY9Prm6+cPUbA3Zy9cCIp7BW8JW7heSn6npvl8SQePtftalJOE+VkM9TiCk5plMtr+X/D8k0mTTF2FWhfem4duAIJjRActWKO1rWlg0VsGEsnuOsist0m2v3nfCw=" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=debug msg="completed challenge" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:08 bcik go-librespot[7037]: time="2026-10-13T22:12: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 13 22:12:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:11 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:11 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:12 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1881. Oct 13 22:12:12 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:12 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:12 bcik go-librespot[7046]: go-librespot daemon starting... Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=debug msg="app state loaded" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12: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 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12: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 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12: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 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=info msg="zeroconf server listening on port 39363" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=debug msg="obtained new client token: AAGE3h6h0HlkwfP9gb/1YMA645GwEuy0+KaFsYVh59oCOwhQyGjvXfAndBZah/oqJFYy0uFPyA5d2DhDZbJ/cmjTpEmdQIMzoQnI8tQaHG4RiX5RHRVM7Njl6XbY9lUMGE3UiAbJgpcQbli/2QOyL72ZXlPLYNLpVsDJmiRKx+eEzT6ndpC7L4Ig0pFzhbSLqQW/WtynwEZhnn6VNEoHF/c5m7wRvJasirNpc53FKelDC4X6R907" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+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 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=debug msg="completed challenge" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12:12+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:12 bcik go-librespot[7047]: time="2026-10-13T22:12: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 13 22:12:12 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:12 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::volumioGetBrowseSources Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 22:12:13 bcik volumio[6643]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 13 22:12:13 bcik volumio[6643]: info: Completed starting MyVolumio Plugin Oct 13 22:12:13 bcik volumio[6643]: [Metrics] CommandRouter: 31s 555.47ms Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::volumiosetStartupVolume Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::Close All Modals sent Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::Close All Modals sent Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 22:12:13 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 22:12:14 bcik volumio-remote-updater[9031]: Test mode disabled Oct 13 22:12:14 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 13 22:12:14 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 13 22:12:14 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 13 22:12:14 bcik volumio[6643]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 13 22:12:14 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 13 22:12:14 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:14 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:14 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 22:12:14 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 22:12:14 bcik volumio[6643]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 22:12:15 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1882. Oct 13 22:12:15 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:15 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:15 bcik go-librespot[7077]: go-librespot daemon starting... Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=debug msg="app state loaded" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12: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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+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 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+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 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=info msg="zeroconf server listening on port 41493" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=debug msg="obtained new client token: AAE+ZrYNo/z7stokOsTiXiwEHroXv5X1esrlDaXo28ZG/HBWKvkBXorAHiWP802B4HkTDNwE6EITbXqG1bTFaIiS8+gOn8w7Rg/MB3+zGy1QwWhxC6FXvUnfCqOrfhwFTfekjVFiV2T3KNTtrgZXcxNP/HSTcCHPN9IkfhgScazSG9dxxnNQSjRfniNMJ96mlk9f8bfdK7AeK5o5b9in2x1Y1loEv5uZ2u1yPA6SwWSIwREoMv1FZMU=" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+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 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=debug msg="completed challenge" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12:15+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:15 bcik go-librespot[7078]: time="2026-10-13T22:12: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 13 22:12:15 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:15 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:17 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:17 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:19 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1883. Oct 13 22:12:19 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:19 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:19 bcik go-librespot[7087]: go-librespot daemon starting... Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=debug msg="app state loaded" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+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 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+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 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=info msg="zeroconf server listening on port 43149" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=debug msg="obtained new client token: AAGN7a2eh6c2IWs1NJ3dLlOmmpKzhZOhvXrd0/kIXRMn2FH8I5QORoS/pLHBMPeuRbPvFU1g9crDaTUR1QQ15cu7k757qkV+iv+3mjBAad6Ox4aSzzb1T5LwiGCNYMkTT333vkje0QEOB2NWL9YR6CSUfwRmRCkB+Vzd8KHMLkNCHe0buNSN6mCS6OzP4oYRSQ/HVfRhN4eEJMYCH9C5eIS0s3OX6GhPiRYAzelr1++5/UbgthK0" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=debug msg="completed challenge" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12:19+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:19 bcik go-librespot[7088]: time="2026-10-13T22:12: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 13 22:12:19 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:19 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:20 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:20 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:20 bcik volumio[6643]: info: BOOT COMPLETED Oct 13 22:12:22 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1884. Oct 13 22:12:22 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:22 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:22 bcik go-librespot[7097]: go-librespot daemon starting... Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=debug msg="app state loaded" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12: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 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12: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 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12: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 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=info msg="zeroconf server listening on port 38883" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=debug msg="obtained new client token: AAH7j0ULuAwUDmb1LohhjYu4HD/cwSqxVZqSPu/KdEC9QlZu5z0rdR+zkkPZskPsf/h0SHflUK20XwufkVk/KKpzejIdU40roOnpF+loztrZE+R84388XMoOpk38wrAOPVHntFSZYkouUkxobIAk/N0P/TmpoHXQW5/Z/II9X6TAohvrHzqKMWt2tQk/IMm0clYiBSHsMEcBKzQUGzt+vgDUd0lIKt9zSfqofs58DaPJdP+VagWxMGE=" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=debug msg="completed challenge" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12:22+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:22 bcik go-librespot[7098]: time="2026-10-13T22:12: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 13 22:12:22 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:22 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:23 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:23 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:26 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1885. Oct 13 22:12:26 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:26 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:26 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:26 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:26 bcik go-librespot[7121]: go-librespot daemon starting... Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=debug msg="app state loaded" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+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 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+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 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=info msg="zeroconf server listening on port 39371" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=debug msg="obtained new client token: AAE8Mv02CgiN63yM1xOoMCsF11QHIosg5kVheJpu896hvcDQw3Jiynk4WlICYET4mzKmM8M/bKWeEcQwuJR4Pv4c9MJLtTYBjlwh19QdFUrx3C9OrHcvstQBq+yVU074BA8Z+EwqpkuFYR3wQuRxVLwVxJ4aq8guW+FQn1GEZ9Cw0Qiz4H1vw7Mm9NDC1Zlx35KpgdbQYJ5qJA+WxIZPMG213Uapm8oE0N6jyFKjpPPHqa7qWxI/" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=debug msg="completed challenge" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12:26+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:26 bcik go-librespot[7122]: time="2026-10-13T22:12: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 13 22:12:26 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:26 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:29 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:29 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:29 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1886. Oct 13 22:12:29 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:29 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:29 bcik go-librespot[7131]: go-librespot daemon starting... Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=debug msg="app state loaded" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12: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 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12: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 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12: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 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=info msg="zeroconf server listening on port 38239" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=debug msg="obtained new client token: AAF0zvyLxFLXVd1ncIubZxidheQrRnuvEgWawn6UM8b9WXfkdo8aacZAaI4syrVYa/OSxYUaV81UDQEe/ZMU1DXmSNRk3xHzH5En9Pi0S+c7YoBQMdpWnrxsTj2L8W60202nJJpboOCcJ8SxIdmAUAlvuF16KdVjpffkgeI7DD6DRZtsR7xle5f3ZJMsf9rpCfwxEr4bZHO9VD1HDkqyhE9gCakYtb9fclWwajE7iTmEZ9iXt+vABLE=" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=debug msg="completed challenge" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12:29+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:29 bcik go-librespot[7132]: time="2026-10-13T22:12: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 13 22:12:29 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:29 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:32 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:32 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:33 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1887. Oct 13 22:12:33 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:33 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:33 bcik go-librespot[7155]: go-librespot daemon starting... Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=debug msg="app state loaded" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+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 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+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 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=info msg="zeroconf server listening on port 43273" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=debug msg="obtained new client token: AAEJNRUO5wBZxNzNBBCC4FL7JtuVbbLLLyroINrd9k6CiaCZX39081vwy3BPzX9+Au087Wo4YN3Zs/0AR1uvEsf2RlzU17dhTati2vtV8AMbqd8Uw4dckrdBu5qz8R9I2UxonV6Z9NbeQcfI30TILVZ2WmsK1vjKr6p+Ngrui6d3CtssXzvw4EnSbYjyPgR/EdaqGavzOk0Qs5qgsVHI/CTViUAhfhSF0zm0+newPtvzThhu0P7f" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+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 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=debug msg="completed challenge" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12:33+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:33 bcik go-librespot[7156]: time="2026-10-13T22:12: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 13 22:12:33 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:33 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:35 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:35 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:36 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1888. Oct 13 22:12:36 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:36 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:36 bcik go-librespot[7166]: go-librespot daemon starting... Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=debug msg="app state loaded" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+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 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+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 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=info msg="zeroconf server listening on port 43633" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=debug msg="obtained new client token: AAH/l0DXbV/CrbU+7eIoilpDxfOmdPkbtHYedhPh3CwF5nlzO5b+/G0QsdmOrqx2NzXWtw9c/uWL78d4mCj6kLGmq5VZLY7XKfIXwS7n1CNZhfHj5wMRQe5CCv9Fpxo6DrX9mpW/oXe4RAVsFWKHdNDvSOKNc2jo8uCUSxG3Bn5LIni0zGZxhq5njdKfBq1EK19qAK0m4wnbdTAo6eI+bGWbfzeNUBlfcs8ln1HKktBWCnlJqF35D8Q=" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=debug msg="completed challenge" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12:36+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:36 bcik go-librespot[7167]: time="2026-10-13T22:12: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 13 22:12:36 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:36 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:38 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:38 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:40 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1889. Oct 13 22:12:40 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:40 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:40 bcik go-librespot[7177]: go-librespot daemon starting... Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=debug msg="app state loaded" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+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 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+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 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=info msg="zeroconf server listening on port 45271" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=debug msg="obtained new client token: AAE9bLxXIBRVypvO+H/UAFICvaY/tvLjamaf4y8KBR4WAQEXqJYMwmIligZguTVOiyeEWh381KC5zG9j9opL7RHTQXtXdjTSuAgoCyAtbSlhMgEH3eRSY24pntLfz+iPojUQTu2i+VUJWGKXrrFT31T5c8lcgv9VFAJRrtH7f6eEWFaY5b8GmoQCfJ85qkjVDvVfHL9GpqpH9CfmNBQ+dj1tnJHhfTMZ1UYDF67TpvVcojUojMZO" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=debug msg="completed challenge" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12:40+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:40 bcik go-librespot[7178]: time="2026-10-13T22:12: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 13 22:12:40 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:40 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:41 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:41 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:43 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1890. Oct 13 22:12:43 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:43 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:43 bcik go-librespot[7201]: go-librespot daemon starting... Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=debug msg="app state loaded" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12: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 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12: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 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12: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 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=info msg="zeroconf server listening on port 40867" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=debug msg="obtained new client token: AAFTyIbe6FEhO4TgmqBumvPpZbgLsy4aDBCVHrlE21IYR8HOp/tMmAsd0BYO2XNtx4Bxbl6VH/MLRsVaPIOjtmETxOBKzUqM8HeUdnJ4aZRdiKWFzyMc/SY2F2GcTIqbIi1jkRYsHARLLsU4NjOqRv+kLPsg641zk1rYdva0Y4msrNQFxBtiCJsww0tNHeQHZSyfVyoK95o6ue4xKvWzTKychaQhi4AfWqHFsVXseB8y7ibww35bNUM=" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=debug msg="completed challenge" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12:43+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:43 bcik go-librespot[7202]: time="2026-10-13T22:12: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 13 22:12:43 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:43 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:44 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:44 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:47 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1891. Oct 13 22:12:47 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:47 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:47 bcik go-librespot[7211]: go-librespot daemon starting... Oct 13 22:12:47 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:47 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=debug msg="app state loaded" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+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 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+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 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=info msg="zeroconf server listening on port 35753" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=debug msg="obtained new client token: AAG+QySwg+yDSIxWkwgIpgnbSCTjkzcqiWh9jvnI3ndjtmUjlc5cCfyyZI02dBY9b8cdZ2eN2YOoXwLuNx0efjRhMffaThgWy/cypbUT/VrQc7TqTGT67lpHrhb1Lryifl/r5yCIkzwzLw6yEAF2UQ6FwFdqHnwvBBWwAv6YYgdKI+EOr0WIKVzPuoHCkHAR9gNGEpPbqdbBMya5lObpbFto2Qd11gEZf38zBIqDEbDYNp9ExqIv" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=debug msg="completed challenge" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12:47+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:47 bcik go-librespot[7212]: time="2026-10-13T22:12: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 13 22:12:47 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:47 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:50 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:50 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:50 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1892. Oct 13 22:12:50 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:50 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:50 bcik go-librespot[7221]: go-librespot daemon starting... Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=debug msg="app state loaded" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+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 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+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 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=info msg="zeroconf server listening on port 41091" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=debug msg="obtained new client token: AAGokums7EGBeghgpJ9KZu0TU2A8HzQ1R5qWdCnSKrvdOBeLsSmDrP+UD/Cd5yZb5VRPV+xO04Y+K+UC123rIdc511zkXP1JbNVODv7AZI9WIGlNq2ffwDYA9/xAO8/3oxcGQASPMUA833tX6Gq7v/9mFfJxHR9uvu0BUCHNtMNDtIw8oONdkgBjiUfL9Owm0znviFIk9HNGFMAwB5dLEXOpV3r6P0fhuqKPxJw8jWxvrZs/GjGfOjs=" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=debug msg="completed challenge" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12:50+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:50 bcik go-librespot[7222]: time="2026-10-13T22:12: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 13 22:12:50 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:50 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:53 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:53 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:54 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1893. Oct 13 22:12:54 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:54 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:54 bcik go-librespot[7246]: go-librespot daemon starting... Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=debug msg="app state loaded" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12: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 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12: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 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12: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 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=info msg="zeroconf server listening on port 37587" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=debug msg="obtained new client token: AAF4xm9r4+H+qRA47YJuVoIWioPsK07yI7tc6VFZZ1N8CQwqN5zy3UwcrZw9E0ERilnCjV4ExmSUNeEo0SNmpIIyJNzKQ90oqgQw/uxW8I1binZdFrEgCGTkxrcj392ns7gSoyc6I1zobd6bFbSx20Wg/f7OqSd/+Mk27aDkS6/xrdb4pa5L5qGdxfN9QQK1NcN5ACEgB9DrRDU/LfPJM3W0ueeE9UE8Uz94JjW09C4mQ9Kj6xpk" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+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 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=debug msg="completed challenge" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12:54+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:54 bcik go-librespot[7247]: time="2026-10-13T22:12: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 13 22:12:54 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:54 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:56 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:56 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:12:57 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1894. Oct 13 22:12:57 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:57 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:12:57 bcik go-librespot[7256]: go-librespot daemon starting... Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=debug msg="app state loaded" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12: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-gew1.spotify.com:80]" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+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 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+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 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=info msg="zeroconf server listening on port 37819" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=debug msg="obtained new client token: AAELBD30oPbcgQDlG2UwbaYs7RfKC+QhIsJsQG5S/5WBIgBLUd+HvfD8FPi6HNh1M2ygxDVrp30OblmiHx7DrbxHB3oBoojt9qaIea1oTS7nJX/nSl5syrC8qKoNLBrjiUhyXLYc/ZGDVnQjmg7ANhZqFFMd0fAqJwXPSnSuakgP73iV/hCZcNpz3UVfx/PpthgL8xsXfee421QtLhVGfjjP1aA22Vtz1/Wkczqz+GGd19RXIneSZUg=" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=debug msg="completed keyexchange" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=debug msg="completed challenge" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12:57+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:12:57 bcik go-librespot[7257]: time="2026-10-13T22:12: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 13 22:12:57 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:12:57 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:12:59 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:12:59 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:13:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1895. Oct 13 22:13:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:01 bcik go-librespot[7266]: go-librespot daemon starting... Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=debug msg="app state loaded" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13: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-gew1.spotify.com:80]" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+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 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+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 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=info msg="zeroconf server listening on port 38797" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=debug msg="obtained new client token: AAFA/QI2Wxn10HTys5EHpkGITDCHnlbJk4aLegKyLnGeSu3xGJdvzBKa7WHiGS+B6WT1DpvxL9Mmgur9h40PYPEPwqDpv2Ll4DdNrb1bDvkUXnKGpbDrotQJgJbQq5vsbnsMN+LAG6t/ncuT3MonuZ/gQqh+nYaMmeCgYcoh/6pAMdbKcWvsFZETVTz+cxKGiyO7utAw4x0eudxiPmbURqaiqcwF1KSAhr2E00y+er0MvMWuGw8Y" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=debug msg="completed keyexchange" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=debug msg="completed challenge" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:13:01 bcik go-librespot[7267]: time="2026-10-13T22:13: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 13 22:13:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:13:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:13:02 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:13:02 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:13:04 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1896. Oct 13 22:13:04 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:04 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:04 bcik go-librespot[7290]: go-librespot daemon starting... Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=debug msg="app state loaded" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+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 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+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 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=info msg="zeroconf server listening on port 46327" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=debug msg="obtained new client token: AAH42SKSNzPCmb7pTI+LkF/voA/o+sYDHebTuS7uVwtrB3ligmGjk2+qZqMWjC7ZB+Xr8Crm0lW7GbSQC0y++SQ6V3zSdXbtNwkhEEmu4VLb8jPMCMKri5t0UpeLYmdHxC9wof8KQ5xGt6bx7Ml4PTy6/OpZqK+ueI+uh8wRjGxVSNnf0fLjxUUis5YPf3rkGJgwdlMmNfLfk6V02VYHKUvX7PiCVExG7Bv+aKvldu+YlXhqsH5prh8=" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=debug msg="completed keyexchange" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=debug msg="completed challenge" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13:04+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:13:04 bcik go-librespot[7291]: time="2026-10-13T22:13: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 13 22:13:04 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:13:04 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:13:05 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:13:05 bcik volumio[6643]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:13:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1897. Oct 13 22:13:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 22:13:08 bcik go-librespot[7300]: go-librespot daemon starting... Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="app state loaded" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 22:13:08 bcik volumio[6643]: info: Initializing connection to go-librespot Websocket Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="new websocket client" Oct 13 22:13:08 bcik volumio[6643]: info: Connection to go-librespot Websocket established Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13: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 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13: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 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13: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 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=info msg="zeroconf server listening on port 43117" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="obtained new client token: AAHPgZGnrBVXEtnRKfqIf7oJOxnO4OpKJZrwLYKyjXN447Xbc8IaDFltjO8GP5iR0ucDpn7coQrpk2WHvqKzH90nyNlq8ry5isj3ipgNgqoB6tW806GR0BcpJkxxeIpEhGIFAP2Q0BOitJq6WvSDN2y2HF3dQywK9ZvJfbvviU0PLxkNX9ESxQr+xT+JYYzLjpnwvtGHiDD3ex6ysEh3F9rVK0qCsSMGDCw7J8jtmrEz4J4xl/tC" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="completed keyexchange" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=debug msg="completed challenge" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 13 22:13:08 bcik go-librespot[7301]: time="2026-10-13T22:13: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 13 22:13:08 bcik volumio[6643]: info: Connection to go-librespot Websocket closed Oct 13 22:13:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 13 22:13:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 13 22:13:11 bcik volumio[6643]: info: Getting Spotify volume Oct 13 22:13:11 bcik volumio[6643]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 22:13:11 bcik volumio[6643]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 13 22:13:11 bcik volumio[6643]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 13 22:13:11 bcik volumio[6643]: errno: -111, Oct 13 22:13:11 bcik volumio[6643]: code: 'ECONNREFUSED', Oct 13 22:13:11 bcik volumio[6643]: syscall: 'connect', Oct 13 22:13:11 bcik volumio[6643]: address: '127.0.0.1', Oct 13 22:13:11 bcik volumio[6643]: port: 9879, Oct 13 22:13:11 bcik volumio[6643]: response: undefined Oct 13 22:13:11 bcik volumio[6643]: } Oct 13 22:13:11 bcik volumio[6643]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 22:13:11 bcik sudo[7324]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 22:12' Oct 13 22:13:11 bcik sudo[7324]: 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"