Oct 12 04:35:00 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4047. Oct 12 04:35:00 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:00 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:00 bcik go-librespot[10978]: go-librespot daemon starting... Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=debug msg="app state loaded" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+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 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+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 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+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 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=info msg="zeroconf server listening on port 39855" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=debug msg="obtained new client token: AAGtoQhooFPSJ2NDMeUTfK9LVR4kpnmVI3YjXGieYdPpHGQio+/tGaCf4cJzgMcqmCLvM3BiqYJYHx3A6yUALmXSd8V9e0l2FEwJxTpCd+muoXSaW9X2ur44p710Cf5WTMqIYjsUVDGlcbRaoMf+kTRcJoFkiZUEPuOEikfHWLyZjQhJ4KCfr+3bvtKosYHadjGTTYk/bLC8IZQA8Wqdw4hPOyzL3Y4b1uYT2H6o44kadBeucEqbzJ8=" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=debug msg="completed challenge" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:00 bcik go-librespot[10979]: time="2026-10-12T04:35:00+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 04:35:00 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:00 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:02 bcik sudo[11003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 04:35:02 bcik sudo[11003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:02 bcik sudo[11005]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 04:35:02 bcik sudo[11005]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:02 bcik sudo[11003]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:02 bcik sudo[11005]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:02 bcik sudo[11007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 04:35:02 bcik sudo[11007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin bluetooth to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin multiroom to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin metavolumio to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin cd_controller to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 12 04:35:02 bcik sudo[11007]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 12 04:35:02 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:02 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:02 bcik volumio[10731]: info: Starting MyVolumio Remote Streaming Endpoints Oct 12 04:35:02 bcik volumio[10731]: info: MyVolumio login type: Token Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 12 04:35:02 bcik volumio[10731]: info: Streaming services startup Oct 12 04:35:02 bcik volumio[10731]: info: Starting Streaming Daemon Oct 12 04:35:02 bcik sudo[11012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 04:35:02 bcik volumio[10731]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 12 04:35:02 bcik sudo[11012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:02 bcik sudo[11012]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:02 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:02 bcik volumio[10731]: error: Cannot start Volumio Streaming Daemon Oct 12 04:35:02 bcik volumio[10731]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 04:35:02 bcik volumio[10731]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 04:35:02 bcik volumio[10731]: info: Upmpdcli Daemon Started Oct 12 04:35:02 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:03 bcik volumio[10731]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 12 04:35:03 bcik volumio[10731]: info: MyVolumio token set successfully Oct 12 04:35:03 bcik volumio[10731]: info: MYVOLUMIO: Adding device Oct 12 04:35:03 bcik volumio[10731]: info: MYVOLUMIO: Evaluating Server Oct 12 04:35:04 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4048. Oct 12 04:35:04 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:04 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:04 bcik go-librespot[11021]: go-librespot daemon starting... Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=debug msg="app state loaded" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:04 bcik volumio[10731]: info: MyVolumio status changed Oct 12 04:35:04 bcik volumio[10731]: info: Streaming services startup Oct 12 04:35:04 bcik volumio[10731]: info: Starting Streaming Daemon Oct 12 04:35:04 bcik volumio[10731]: info: Removing browser output: myVolumio user plan is not superstar Oct 12 04:35:04 bcik volumio[10731]: info: Removing audio output: Oct 12 04:35:04 bcik volumio[10731]: info: Stoppping Tunnel 1 Oct 12 04:35:04 bcik sudo[11047]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 04:35:04 bcik sudo[11047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:04 bcik sudo[11049]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 12 04:35:04 bcik sudo[11049]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik sudo[11047]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:04 bcik volumio[10731]: error: Cannot start Volumio Streaming Daemon Oct 12 04:35:04 bcik volumio[10731]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 04:35:04 bcik volumio[10731]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 04:35:04 bcik sudo[11049]: pam_unix(sudo:session): session closed for user root Oct 12 04:35:04 bcik volumio[10731]: info: Remote SSH Stopped Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35: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-gew1.spotify.com:80]" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+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 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+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 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=info msg="zeroconf server listening on port 46855" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=debug msg="obtained new client token: AAHVS//MjHxuqngzlV55YkiM1OakSDZUJr7xq7BO2kUzsH5dbNjIBKDtDLMZMJJMzhEZlLsueC9CBb0qWuiFvsRcxxcNnqeVkNaURjw9impFEwy3/93w4+ulf6hSOMsQknW8ip0w74yBViqJQVY2vCHwRNxmIsKXQy3GzoBoShazwRsaI7wOc5e6lQtRFKNFOpKRvCg0Sm1AgjnvR6d7pXRUqB/RBsQETAotx5f7/UVKCz6RbrS0" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=debug msg="completed challenge" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35:04+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:04 bcik go-librespot[11030]: time="2026-10-12T04:35: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 04:35:04 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:04 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:04 bcik volumio[10731]: info: Setting Geolocation for MyVolumio to eu7 Oct 12 04:35:04 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:04 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:04 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:04 bcik volumio[10731]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 04:35:05 bcik volumio[10731]: info: Updating MyVolumio device info Oct 12 04:35:05 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:05 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:05 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:05 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:05 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:06 bcik volumio[10731]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 04:35:07 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4049. Oct 12 04:35:07 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:07 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:07 bcik go-librespot[11055]: go-librespot daemon starting... Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=debug msg="app state loaded" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+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 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+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 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+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 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=info msg="zeroconf server listening on port 34237" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=debug msg="obtained new client token: AAGupGLoeVWj2ALoHDBZSy3l4cLOE/idaEDAdDkLef7+2Bgk8tUfDuwuxasTD5OOBFmOvitJcCvlM1Z0CHUqrStjRqlxCdUSD7SMirrxiwJzb6hJsfzvHSxz0Le4Q8blaTbS+ggkUsd+md01Syk6iZx0xlT5EMlUJPld+K4yLLRns9P/lO2Ud/cOBiXIsoAOuaEegflYfpHN83ZO9JtjnQ7w7GeW7dc3ix2IyK0vD3MgrIFYSPao+tg=" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=debug msg="completed challenge" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:07 bcik go-librespot[11056]: time="2026-10-12T04:35:07+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 04:35:07 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:07 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:08 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:08 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:08 bcik volumio[10731]: info: MYVOLUMIO: Adding device Oct 12 04:35:08 bcik volumio[10731]: info: MYVOLUMIO: Evaluating Server Oct 12 04:35:09 bcik volumio[10731]: info: Setting Geolocation for MyVolumio to eu6 Oct 12 04:35:09 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:09 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:09 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:09 bcik volumio[10731]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 04:35:10 bcik volumio[10731]: info: Updating MyVolumio device info Oct 12 04:35:10 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:10 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:10 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:10 bcik volumio[10731]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 04:35:11 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4050. Oct 12 04:35:11 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:11 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:11 bcik go-librespot[11083]: go-librespot daemon starting... Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=debug msg="app state loaded" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+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 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+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 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=info msg="zeroconf server listening on port 33651" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=debug msg="obtained new client token: AAFtufGPXLTDBBuZ4ifAJcVGO5d2sNpU99d9XGbAuUsavrfA/jSzhNB40/taecs7JomrMcjwQQfBONd0ktGYfHCgoyGX9lMFhO8kExqXgvBCNsSFilxxnbgGPC70GpuTR7zdTt4ko8TuZ9MdFWkJrmUvIY5WuvX1mzR3RpwPtc7hO+1TdvtWt5gfogdULNdhuz3XvIesG93WfPU+xboRz/Z95YwlNozoxYw3WuH55cG1OrSVSsg4" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=debug msg="completed challenge" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35:11+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:11 bcik go-librespot[11084]: time="2026-10-12T04:35: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 04:35:11 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:11 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:11 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:11 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:14 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:14 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:14 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4051. Oct 12 04:35:14 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:14 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:14 bcik go-librespot[11107]: go-librespot daemon starting... Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=debug msg="app state loaded" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+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 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+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 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+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 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=info msg="zeroconf server listening on port 36089" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=debug msg="obtained new client token: AAGGPLKkYiMIkhc3Z3pEvV9eHDZseozHtvqtD9z1v76O7aIqIgpnwQ7WbXRNZOwHVEbpO5EJihfpw4R9lrLGlV/hri4uvpmN0X1211/akGGXwscThWZAHWssrI/Xm02kI9o2g1MWSlitC6Y2OIPvrr8+aqpmJ5w458E3uyFPC8hckSRO04211stsMnoJIWBtYGy/ZQTnjAuhJwuf5WjEo/tXf1X/J+BS0tPl0DXNwuMgAX35xYzGBp0=" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=debug msg="completed challenge" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:14 bcik go-librespot[11108]: time="2026-10-12T04:35:14+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 04:35:14 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:14 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:17 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 04:35:17 bcik volumio[10731]: 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 04:35:17 bcik volumio[10731]: info: CoreCommandRouter::volumioGetState Oct 12 04:35:17 bcik volumio[10731]: info: CorePlayQueue::getTrack 0 Oct 12 04:35:17 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:17 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:18 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4052. Oct 12 04:35:18 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:18 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:18 bcik go-librespot[11117]: go-librespot daemon starting... Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=debug msg="app state loaded" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+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 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+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 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=info msg="zeroconf server listening on port 35061" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=debug msg="obtained new client token: AAEyb5YGwS2GUs9CBqFzYwMSb8gDv+qQATl2fi65Jx59UR9e8ypw4klN7CEbFQ2QSZkScNU2dxKoRanMyZ2Nmgy4xvuI01IRAnVqNOAXuoxZbBQS2jbODsZwVVJS+to6scfR+m1p7QkIdZjSfT7LcEhwphtRu3C2E5tAScBycuw1wdJkbPV4anz/9SVSfGJ4YS+lSpdQB7pgW4PB7FhAAKxujjYmqYtx6O2EsIkZ/lCBnotpfsOz" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=debug msg="completed challenge" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35:18+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:18 bcik go-librespot[11118]: time="2026-10-12T04:35: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 04:35:18 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:18 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:20 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:20 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:21 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4053. Oct 12 04:35:21 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:21 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:21 bcik go-librespot[11130]: go-librespot daemon starting... Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=debug msg="app state loaded" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+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 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+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 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+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 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=info msg="zeroconf server listening on port 42721" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=debug msg="obtained new client token: AAFZV73bnJNg+VgumPPYeoRHqjTvfbzCvmKuh/ICnT3ffwtBgWP+yil3q2owjpjjXZP7UUNrz34VUPUhXRW/Dd4KrBxMhCSyUeB+FS7MXsefIM5ZVvZu9Vm0sDDKSAnTXCEveAIqJTL/eAXct0sIzsyUVkrAJmxrWgOcptJImrXysc6zojYsHlbaNvonQqAf7hLtPyOruR83qg9b/MURhDkyi97Mlv+x1Oi3PCYh3qZ8ra9ePL1vC7Q=" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=debug msg="completed challenge" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:21 bcik go-librespot[11132]: time="2026-10-12T04:35:21+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 04:35:21 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:21 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:35:22 bcik volumio[10731]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 12 04:35:22 bcik volumio[10731]: info: Completed starting MyVolumio Plugin Oct 12 04:35:22 bcik volumio[10731]: [Metrics] CommandRouter: 30s 817.73ms Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::volumiosetStartupVolume Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::Close All Modals sent Oct 12 04:35:22 bcik volumio[10731]: info: CoreCommandRouter::Close All Modals sent Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 04:35:23 bcik volumio-remote-updater[9031]: Test mode disabled Oct 12 04:35:23 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 04:35:23 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 04:35:23 bcik volumio[10731]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 04:35:23 bcik volumio[10731]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 04:35:23 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:23 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:25 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4054. Oct 12 04:35:25 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:25 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:25 bcik go-librespot[11162]: go-librespot daemon starting... Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=debug msg="app state loaded" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+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 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+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 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=info msg="zeroconf server listening on port 32859" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=debug msg="obtained new client token: AAGD7tPnnzMVAiAhSysTVMHA3EebxWnrynTuG8DvuwA8zSqhSXa2KQ6/ZWaeKh0r+euFJC3dz1en+8TOBIlVq35XbosV/kumzbBbbcWdfxogRoeSfBXzWyXGaGnQ9mthZxOdsgINEWeQU0H1Tstjhwgpeyy9o7ACPBdeuzv9IL16WeQn0CyKikIpn0E5AMFHy3SfXfGxQSEL5DDhChgu17HhGZwaVRUDTbNS7C4s449Phu46w4cb" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=debug msg="completed challenge" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35:25+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:25 bcik go-librespot[11163]: time="2026-10-12T04:35: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 04:35:25 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:25 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:26 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:26 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:28 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4055. Oct 12 04:35:28 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:28 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:28 bcik go-librespot[11173]: go-librespot daemon starting... Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=debug msg="app state loaded" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+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 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+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 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+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 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=info msg="zeroconf server listening on port 36385" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=debug msg="obtained new client token: AAHjXTk9aTZqGQTkTz3Dqwq7NxHJPDuZTLi7jSHqDHoFjj0MwBPvhoPwxiSFPUFpUDR3OsS1NUwWtRh0HhfJ24Ec4nPKiiDQmdLC97nJP9HEGbvsmO2wCSOJqQWNRWwTMHr2f5GqC6kJ88C3dP+KXQ0j4CTwrbnu+Tn3HsuiJjuzYaipP3ptl8tGZqxt7e7fnPbXqDySEmx3kQmv56TYlIMnZo18K0CBMglFuZowWrhe+2mCKRD6Y6Y=" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=debug msg="completed challenge" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:28 bcik go-librespot[11174]: time="2026-10-12T04:35:28+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 04:35:28 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:28 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:29 bcik volumio[10731]: info: BOOT COMPLETED Oct 12 04:35:29 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:29 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:32 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4056. Oct 12 04:35:32 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:32 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:32 bcik go-librespot[11183]: go-librespot daemon starting... Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=debug msg="app state loaded" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+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 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+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 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=info msg="zeroconf server listening on port 43693" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=debug msg="obtained new client token: AAHLS3+lwbstYl+z/0Gvrc7OE+zElwvXDpxNgDVJULIuhCQ7LFMfsv5x5h0i8Mqjx/lduw1jWcQw2PC1XrFGzhm56VlG5otiWpwK6WDQw0t/EfiagNq1LXFdAiBFCwrGULVaNEAWVrFcPFXO33uTFsK1vsm/VzTSQ/yX2D1QarmqwLxzTKXHO0KvtYIcHyidNGIVruGXLGJUuymFnFTgKEgxzlBRXGb6XwHDgJy5zkfhfyMBIQtp" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=debug msg="completed challenge" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35:32+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:32 bcik go-librespot[11184]: time="2026-10-12T04:35: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 04:35:32 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:32 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:32 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:32 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:35 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4057. Oct 12 04:35:35 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:35 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:35 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:35 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:35 bcik go-librespot[11208]: go-librespot daemon starting... Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=debug msg="app state loaded" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+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 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+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 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+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 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=info msg="zeroconf server listening on port 40853" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=debug msg="obtained new client token: AAH+lsMIgV0r6l7GwBHcFm6qybVPf9sSZ3jTeI4lIDQs+2JX3PIeCa9AeGdSzoIRRlDI3MuNv6MfsSpwPXF75BsG34Tks1X68uBp2F08rdbMguTgi+fCnPn+2PA3JU60ISoWEAAYgkUGb6chkAd02bM+obGwblttq5ZCPVldUwp+1Bc85JtkQ9jdZez/U6IKriAHyTzElI1R/Rcl+bzrVr7wMsAK2RKd5aPH1XiMHkM+5ajr6tRqbHg=" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=debug msg="completed challenge" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:35 bcik go-librespot[11209]: time="2026-10-12T04:35:35+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 04:35:35 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:35 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:38 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:38 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:39 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4058. Oct 12 04:35:39 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:39 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:39 bcik go-librespot[11219]: go-librespot daemon starting... Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=debug msg="app state loaded" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+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 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+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 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=info msg="zeroconf server listening on port 41579" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=debug msg="obtained new client token: AAGwil5jqTSovdjY7e/I4Qfi2WK/vH3PYfDQS0t1Wwav7qaF4EwjYKBrYzUSaK63754j8lahTACJjh2J033AUVrNtRu0xxDwyoSILOE8a7pw7HSH67eTcRbnXVhwMGGq+5I8ABOCv6X2xZFYiE44fq8Oh69Q1ZrzF45Bhb+p71KE966mn2T7w6lmkKS9BlO+xBhrGgEfLGjNFFTVrraHV0avGaeD44WNzPHtaKc+gVuaz/t/sgVa" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=debug msg="completed challenge" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35:39+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:39 bcik go-librespot[11220]: time="2026-10-12T04:35: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 04:35:39 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:39 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:41 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:41 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:42 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4059. Oct 12 04:35:42 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:42 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:42 bcik go-librespot[11244]: go-librespot daemon starting... Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=debug msg="app state loaded" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+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 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+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 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+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 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=info msg="zeroconf server listening on port 38719" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=debug msg="obtained new client token: AAH/6feTj33/78Lctbr83N3eNRv/Qls4v/nywpqtROBN9zijNONjhi9VGUr2xhstBfS+1v14z2ubKh5/WL6SUbClTD/Ac0GqnrfOwscbc63zj3s3di1XJYSQHsleJ98tMNNR7/3/2EBa2zpSHaHBgklz5QWQVs7b7uCXKKpHVdvXr5TpgLcwkPVkz1xdiAc8/gPbE/uTodRPpX7x6DFAaC6G4cZZbOlbYDroZccdhsjZ1dSmGyxst/4=" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=debug msg="completed challenge" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:42 bcik go-librespot[11245]: time="2026-10-12T04:35:42+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 04:35:42 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:42 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:44 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:44 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:46 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4060. Oct 12 04:35:46 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:46 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:46 bcik go-librespot[11254]: go-librespot daemon starting... Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=debug msg="app state loaded" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+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 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+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 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=info msg="zeroconf server listening on port 42413" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=debug msg="obtained new client token: AAGNiuNnuKBBYhsz+XH00u873KsjfKV0WkCdNO+EmGjoMlFKKu62JtfsK2NsbfciSFP09UAoxSDzW+EBRl3ICHnFiGbBtgB9sHa3Ppx057WcY1MwRcCcsfJ5wNP5PkUvyD4EXUUIf2vsvHHAKXfDW8ppaYilgtgnHfYX/dz27ccGYkPIME63opzPS9CIiwEdnqDkGyHzprWqPIcgM8hy1r5jMGTOH+9A6x3MaKjEhP7BcjaHecb4" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=debug msg="completed challenge" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35:46+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:46 bcik go-librespot[11255]: time="2026-10-12T04:35: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 04:35:46 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:46 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:47 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:47 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:49 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4061. Oct 12 04:35:49 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:49 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:49 bcik go-librespot[11265]: go-librespot daemon starting... Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=debug msg="app state loaded" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+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 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+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 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+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 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=info msg="zeroconf server listening on port 37419" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=debug msg="obtained new client token: AAEd5Enx/gBV6FwzCulk5fAVYMoZKzGbKVSR/gml8dLd8GxjqalSx0mos+TPDeyNWiLTvgaOy6mGVmlrkEEylLbAyNQ823IoRFkseM49YxeBb0SC3xp4MAlqJuPvaMmDNIxrxmlJreDWaqsVZ2YLnN7F/+J9jn13e+Z/rklwoVFPppfihInKf2Fn30A5/D1zKvdF8PIC5ccr+86pNUvf8kB6t0189cqybPX+wZgNy8I6lo+v/xD4hnQ=" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=debug msg="completed challenge" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:49 bcik go-librespot[11266]: time="2026-10-12T04:35:49+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 04:35:49 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:49 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:50 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:50 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:53 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4062. Oct 12 04:35:53 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:53 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:53 bcik go-librespot[11289]: go-librespot daemon starting... Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=debug msg="app state loaded" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+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 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+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 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=info msg="zeroconf server listening on port 34121" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=debug msg="obtained new client token: AAHTEmtuAqAdUuj0EGenqGIoBkpo4+1Jngk1UFOfmeElHrzBrJ/8ivj8Dx/aTbQfGc83P+2O77mlfW5mMMiiaMWlFBzi956d1S+fvQKYpdoB+UlLaaBu/V23GdGssnpz6eBXD5ahZL17GqRrQvmAhAKWgOD2uLmYkiJVbBa80pygDWLQc58qvkIuHGYGHJTuFwKH/7l+lOS0qtu60y9zN4PYBRSRFG7nmudf+od6rY8rfdPupiXE" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=debug msg="completed challenge" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:53 bcik go-librespot[11290]: time="2026-10-12T04:35:53+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 04:35:53 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:53 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:53 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:53 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:56 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4063. Oct 12 04:35:56 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:56 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:56 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:35:56 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:35:56 bcik go-librespot[11299]: go-librespot daemon starting... Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=debug msg="app state loaded" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+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 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+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 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+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 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=info msg="zeroconf server listening on port 35769" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=debug msg="obtained new client token: AAGdVbfc9Yk2/n8pmh2bRwsv4qXKw+pDZRQsc80eG8lNaeTc83wczYsvLV1amVoc0XQMom0raypCpuGTStxPoV2RWInFjspZGtIf3NR6fITCpauKoPDgS9bP4cFrl+2gZtMbUt+H/goN4yxpsUj5FC9ze9h7ObSTlafiirBCGjo0Tba5p9ywIM8bgo+radmbFq9XhcvE17K0SEcAoT9oZQBDXNKh1KXlXQdoA7gmhuGx2I6PqY28qUc=" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=debug msg="completed keyexchange" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=debug msg="completed challenge" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:35:56 bcik go-librespot[11300]: time="2026-10-12T04:35:56+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 04:35:56 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:35:56 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:35:59 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:35:59 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:00 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4064. Oct 12 04:36:00 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:00 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:00 bcik go-librespot[11309]: go-librespot daemon starting... Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=debug msg="app state loaded" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+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 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+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 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+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 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=info msg="zeroconf server listening on port 36403" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=debug msg="obtained new client token: AAHAqzAzsr76BTUFLs9Uy+NmPTDozN1e7Pb1x09l8Ca0KpEVmlS2lBBWaUW73f2HgbBMDj2MbeywU4N7weCao/XKhRUgekPcmK/YCEKGYmgG2K7PmCfE3GZ8gJFWtqsuWTMX3oPNWXYd94ylcE0ey/FEGMm0p0NLu94c7c43us49yKPabfbutGUJCVdr8CGVc7qnCbaabhAtj4KO7NupRLqQnnbMlrq7LM9ghX08rvH86aDChO3f" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+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 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:443, retrying with a different AP" error="dial tcp 34.158.1.133:443: connect: connection refused" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=debug msg="connected to ap-gew4.spotify.com:80" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=debug msg="completed challenge" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:00 bcik go-librespot[11310]: time="2026-10-12T04:36:00+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 04:36:00 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:00 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:02 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:02 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:03 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4065. Oct 12 04:36:03 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:03 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:03 bcik go-librespot[11333]: go-librespot daemon starting... Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=debug msg="app state loaded" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+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 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+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 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+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 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=info msg="zeroconf server listening on port 45261" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=debug msg="obtained new client token: AAH3L+lqk+h+qcslQWySOsntvcOj6iyBRhlX0INCYGPk0TJvaeQLo4DhMWXEf9b/GT7/BHfy0rxmikTXRBVjm+ITe8Q3WGyJrkreVZzWrA9TE7epnPtPWGQlJ5suSOYom8NYzZAB47kaNWGXYAdzKFg00iVJv7L0aUjEUABeIZOi5zvl5mIEQeG0vNAZyuY289x/E4MaPLON/ciQBCSvj0J+Cf5hs/fMd2kwRAcbUlxKcjfq3ytd1ic=" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=debug msg="completed challenge" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:03 bcik go-librespot[11334]: time="2026-10-12T04:36:03+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 04:36:03 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:03 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:05 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:05 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:07 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4066. Oct 12 04:36:07 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:07 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:07 bcik go-librespot[11343]: go-librespot daemon starting... Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=debug msg="app state loaded" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+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 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+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 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+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 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=info msg="zeroconf server listening on port 35699" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=debug msg="obtained new client token: AAE+FWdMBubcOo2ov76lVxWWm0hjkjsAiIbmFRWXZPYBWAaQE163IeFQ1Cc1gIWz1bRvsKGrIVGQAZLIsyAf6E0vSIWwwUARgVdVznvTj8bmbIriOfZkrtFG7O5RdUREgmnr2ebzqrqruqepdg2RvmLqJso2/IdA6S3ft3otpCtajsG68r07cRD7AoQWfqf/DrjokD2QNNtbbF+VgD/UY7/ogiTRJHipoASrIKmlZNdDYSRFYWWP" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+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 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=debug msg="completed challenge" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:07 bcik go-librespot[11344]: time="2026-10-12T04:36:07+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 04:36:07 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:07 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:08 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:08 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:10 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4067. Oct 12 04:36:10 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:10 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:10 bcik go-librespot[11355]: go-librespot daemon starting... Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=debug msg="app state loaded" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+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 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+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 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+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 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=info msg="zeroconf server listening on port 37445" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=debug msg="obtained new client token: AAH6r9oxJBe+lfIV0U3QzT48kdoU4fc8fmFRp0a+FLi6pYuMC7ybcBYvm/CXa4PO9qlwldERrDYUeghBHKTS1fXn9V/ehoRpRy6np/CvKHBE624Pr4gxEeqbK4iUYQRUJnpkcZSFTxctWL1VH6Hj6CmII6vSPELIr053uLKiJt+JmvUUIbsW7grYtjmyYKBVp1raZ67CGSLsbjecPM26XAU7vAuu6Gf2s75x2/Y/45TZYGzm27tFOcg=" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=debug msg="completed challenge" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:10 bcik go-librespot[11356]: time="2026-10-12T04:36:10+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 04:36:10 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:10 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:11 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:11 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:14 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4068. Oct 12 04:36:14 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:14 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:14 bcik go-librespot[11379]: go-librespot daemon starting... Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=debug msg="app state loaded" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+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 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+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 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+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 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=info msg="zeroconf server listening on port 37213" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=debug msg="obtained new client token: AAEtR/7ktWVZIRg9SqaDuDbtPVZ1wOqrpWN5jiql5OY6QliQ5AiVn9YNdQkDIdhO+I1Vl+/7Dcdv8ntfjWUn4ulwhBEOyp0AXs8+FToPzWNIJHsqC073BYLdabuPabxqBFVi7yVSL/yj2igUwl0aAFtIE2jKqgNswri2iEvoLiLX4fkd8O2o/iKd15Vf9Jv6S9kI8/NUEjHu5nZMTTi+Mv7mkUzkTvl1QvRthHWefPtcbNKRNcGp" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=debug msg="completed challenge" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:14 bcik go-librespot[11380]: time="2026-10-12T04:36:14+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 04:36:14 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:14 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:14 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:14 bcik volumio[10731]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:17 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4069. Oct 12 04:36:17 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:17 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 04:36:17 bcik go-librespot[11389]: go-librespot daemon starting... Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=info msg="running go-librespot 0.6.2" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="app state loaded" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 04:36:17 bcik volumio[10731]: info: Initializing connection to go-librespot Websocket Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="new websocket client" Oct 12 04:36:17 bcik volumio[10731]: info: Connection to go-librespot Websocket established Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+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 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+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 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+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 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=info msg="zeroconf server listening on port 45291" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="obtained new client token: AAEjcW3VRoWvcidgzswUZxeIw8x3mhXtpTUKSjkzOq5tyBzjS2BjzLH8tAxdrBvuvGqTVozxkkeG7D1Kl730KlJLJVbu4tRChUAjDOGj5ieSdqQedy2h1zgY/YFdX5l1TkPqEiR6SrwRl9tWOsE+sdKJ10P5KcRuQh/NVD8IoGGLl3Ra2bYV0iKBvWfzos5b8iKcgsKHZk+n2oOqX1i1AzTC+AEfR+evDblMic3/ynZaQc4KEXzDTQw=" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="completed keyexchange" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=debug msg="completed challenge" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+02:00" level=info msg="authenticated AP" username="la***pl" Oct 12 04:36:17 bcik go-librespot[11390]: time="2026-10-12T04:36:17+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 04:36:17 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:36:17 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 04:36:17 bcik volumio[10731]: info: Connection to go-librespot Websocket closed Oct 12 04:36:20 bcik volumio[10731]: info: Getting Spotify volume Oct 12 04:36:20 bcik volumio[10731]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:36:20 bcik volumio[10731]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 04:36:20 bcik volumio[10731]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 12 04:36:20 bcik volumio[10731]: errno: -111, Oct 12 04:36:20 bcik volumio[10731]: code: 'ECONNREFUSED', Oct 12 04:36:20 bcik volumio[10731]: syscall: 'connect', Oct 12 04:36:20 bcik volumio[10731]: address: '127.0.0.1', Oct 12 04:36:20 bcik volumio[10731]: port: 9879, Oct 12 04:36:20 bcik volumio[10731]: response: undefined Oct 12 04:36:20 bcik volumio[10731]: } Oct 12 04:36:20 bcik volumio[10731]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:36:20 bcik sudo[11413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 04:35' Oct 12 04:36:20 bcik sudo[11413]: 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"