Oct 14 12:30:00 bcik volumio[23544]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 14 12:30:00 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10108. Oct 14 12:30:00 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:00 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:00 bcik go-librespot[23848]: go-librespot daemon starting... Oct 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30:00+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30:00+02:00" level=debug msg="app state loaded" Oct 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30: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 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30: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 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30: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 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30:00+02:00" level=info msg="zeroconf server listening on port 44997" Oct 14 12:30:00 bcik volumio[23544]: info: MyVolumio token set successfully Oct 14 12:30:00 bcik volumio[23544]: info: MYVOLUMIO: Adding device Oct 14 12:30:00 bcik volumio[23544]: info: MYVOLUMIO: Evaluating Server Oct 14 12:30:00 bcik go-librespot[23849]: time="2026-10-14T12:30:00+02:00" level=debug msg="obtained new client token: AAHtsaUfOBEK8DM6MpoNSNb5nFDjzQwUrIkcmfJr7/7OCClBraRlV7U2eAMjnMqKwg1irTcmgUecJVlhWEyO3JUWR/mg8z3cnXrJg1IP0Kn8r4O84+rZC01tXT6lNGlWMLPhZ9RJ/5q/mom/ppLNN47nWBMCYqZM+la2G8qWt3c3lPFvQV4G83JCU9gT3DKauMwE3d63sK5xvcekhrKzMT+RV488zZHcHEt3TDWBSP2RoLPbZOc7qBY=" Oct 14 12:30:01 bcik go-librespot[23849]: time="2026-10-14T12:30:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:01 bcik go-librespot[23849]: time="2026-10-14T12:30:01+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:01 bcik go-librespot[23849]: time="2026-10-14T12:30:01+02:00" level=debug msg="completed challenge" Oct 14 12:30:01 bcik go-librespot[23849]: time="2026-10-14T12:30:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:01 bcik go-librespot[23849]: time="2026-10-14T12:30: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 14 12:30:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:01 bcik volumio[23544]: info: MyVolumio status changed Oct 14 12:30:01 bcik volumio[23544]: info: Streaming services startup Oct 14 12:30:01 bcik volumio[23544]: info: Starting Streaming Daemon Oct 14 12:30:01 bcik volumio[23544]: info: Removing browser output: myVolumio user plan is not superstar Oct 14 12:30:01 bcik volumio[23544]: info: Removing audio output: Oct 14 12:30:01 bcik volumio[23544]: info: Stoppping Tunnel 1 Oct 14 12:30:01 bcik sudo[23879]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 14 12:30:01 bcik sudo[23879]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:30:01 bcik sudo[23882]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 14 12:30:01 bcik sudo[23882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:30:01 bcik sudo[23879]: pam_unix(sudo:session): session closed for user root Oct 14 12:30:01 bcik volumio[23544]: error: Cannot start Volumio Streaming Daemon Oct 14 12:30:01 bcik volumio[23544]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 14 12:30:01 bcik volumio[23544]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 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 14 12:30:01 bcik sudo[23882]: pam_unix(sudo:session): session closed for user root Oct 14 12:30:01 bcik volumio[23544]: info: Remote SSH Stopped Oct 14 12:30:02 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:02 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:03 bcik volumio[23544]: info: Setting Geolocation for MyVolumio to eu7 Oct 14 12:30:03 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:03 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:03 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:04 bcik volumio[23544]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 14 12:30:04 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10109. Oct 14 12:30:04 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:04 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:04 bcik go-librespot[23885]: go-librespot daemon starting... Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=debug msg="app state loaded" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30: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 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30: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 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30: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 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=info msg="zeroconf server listening on port 34111" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=debug msg="obtained new client token: AAHqv5TMXPomS0dwalpN/R6ZlKWePCwfFa1GzzzTHSM+5K3RQldvR+fv0KRaHdm5R4SrCLLi7t7DFC19DAtaYjqM7FnzXYh/1d39cF49n8kwPr3J1gab4osEIL2EOxNgAmufLKkrrfpgI5kG0WlL9tXMK28abCPcXNKQAG2FKCI3dmkEt8TkDdPaDZHgQb4ix89I2VoLLmFGDBEts/BZsBrXgMiPeeXTo1OXp/LHj+RHP2YODpLZWEo=" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=debug msg="completed challenge" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30:04+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:04 bcik go-librespot[23886]: time="2026-10-14T12:30: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 14 12:30:04 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:04 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:04 bcik volumio[23544]: info: Updating MyVolumio device info Oct 14 12:30:04 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:04 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:04 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:05 bcik volumio[23544]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 14 12:30:05 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:05 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:07 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10110. Oct 14 12:30:07 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:07 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:07 bcik go-librespot[23895]: go-librespot daemon starting... Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+02:00" level=debug msg="app state loaded" Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+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 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+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 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+02:00" level=info msg="zeroconf server listening on port 36231" Oct 14 12:30:07 bcik go-librespot[23896]: time="2026-10-14T12:30:07+02:00" level=debug msg="obtained new client token: AAHfu5ue0V9x9VYEMbptaq223NB1nKtqDjJylEPHVga+Cr7KTFuhQ90blxcb77JwTUt+wsHDCPVyGk9cQ4ZnnSD77jNCUEAJtwXYrSkmc0EqYv3ms+xvSC8cYmtp0cPCtGfkCM1pBT4NUb0fkbHXREV0yNxWDfrXbXJkrMg4g1SvpMp5nMeaWkZGD6qBty2Qi0S2fNxnxvQAwyHH0nnKnhU5qnQ47KBBWmtWe7D7amhDsjZgreBFFRI=" Oct 14 12:30:08 bcik go-librespot[23896]: time="2026-10-14T12:30:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:08 bcik go-librespot[23896]: time="2026-10-14T12:30:08+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:08 bcik go-librespot[23896]: time="2026-10-14T12:30:08+02:00" level=debug msg="completed challenge" Oct 14 12:30:08 bcik go-librespot[23896]: time="2026-10-14T12:30:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:08 bcik go-librespot[23896]: time="2026-10-14T12:30: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 14 12:30:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:08 bcik volumio[23544]: info: MYVOLUMIO: Adding device Oct 14 12:30:08 bcik volumio[23544]: info: MYVOLUMIO: Evaluating Server Oct 14 12:30:08 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:08 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:08 bcik volumio[23544]: info: Setting Geolocation for MyVolumio to eu7 Oct 14 12:30:08 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:08 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:08 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:08 bcik volumio[23544]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 14 12:30:09 bcik volumio[23544]: info: Updating MyVolumio device info Oct 14 12:30:09 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:09 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:09 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:10 bcik volumio[23544]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 14 12:30:11 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10111. Oct 14 12:30:11 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:11 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:11 bcik go-librespot[23937]: go-librespot daemon starting... Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="app state loaded" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=info msg="zeroconf server listening on port 34597" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="obtained new client token: AAErNRD/3J4TFc6CqDDiwyCsDQNso+QNkRfpKx6D/9HkqEIfr4RIf7JWqyYaItWtsrsPGs+xlGYtqrFr0NVtzBSvN7PqPlJmDWZlF1AeqLN23tSMXh7tJhegxDGDTZ2Dvd2mGfVrQvQ+YMM8M0MDxKXEHm6cTy9zYWeOMe9pM3DYIkc3AEpcuado+7tN81cPy/O6DQ4lhsuCvMiU2zAbCXT/8BWxYS/aStddpFUBtqlx/1ncXWr6IBI=" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=debug msg="completed challenge" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30:11+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:11 bcik go-librespot[23938]: time="2026-10-14T12:30: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 14 12:30:11 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:11 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:11 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:11 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:14 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 12:30:14 bcik volumio[23544]: 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 14 12:30:14 bcik volumio[23544]: info: CoreCommandRouter::volumioGetState Oct 14 12:30:14 bcik volumio[23544]: info: CorePlayQueue::getTrack 0 Oct 14 12:30:14 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:14 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:14 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10112. Oct 14 12:30:14 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:14 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:14 bcik go-librespot[23947]: go-librespot daemon starting... Oct 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30:14+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30:14+02:00" level=debug msg="app state loaded" Oct 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30: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 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30: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 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30: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 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30:14+02:00" level=info msg="zeroconf server listening on port 38921" Oct 14 12:30:14 bcik go-librespot[23948]: time="2026-10-14T12:30:14+02:00" level=debug msg="obtained new client token: AAFV9L0iHoZ4DAMCSjQM1ORCJkqW1T9rrFBHTIerAwUhcG+0FbzHuhISWoz7mXhR1sgm78pPB5L4W5Jp+wJ8SNZxBEzGxW5zcBHbB9jOwyS/VBOUmrUV1fZEtLqG3KNX/9Sfs7KwbKJtf1Xr+La6vaMTTKITclJoc8AXzQuQfB6nbpD3SU7U59zAHhFdRiYC/ZvTT3IwumN4rdCmXSDJ+mZxTZpGn2vxG6OMt1u3GNoOQr3CD7YQvLk=" Oct 14 12:30:15 bcik go-librespot[23948]: time="2026-10-14T12:30:15+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:15 bcik go-librespot[23948]: time="2026-10-14T12:30:15+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:15 bcik go-librespot[23948]: time="2026-10-14T12:30:15+02:00" level=debug msg="completed challenge" Oct 14 12:30:15 bcik go-librespot[23948]: time="2026-10-14T12:30:15+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:15 bcik go-librespot[23948]: time="2026-10-14T12:30: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 14 12:30:15 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:15 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:17 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:17 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:18 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10113. Oct 14 12:30:18 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:18 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:18 bcik go-librespot[23957]: go-librespot daemon starting... Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="app state loaded" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+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 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+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 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=info msg="zeroconf server listening on port 42871" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="obtained new client token: AAHSq+8vorlK7w68+Ifo+9oVIYxGbxk7Cnn6ocupKwU+AE9ANPxvNQaC7+wjdTbVTmyZFO5aqENkw1QF5okDTZF82koljzqGJsgiarR9TgOkoBb3tMLshxJG1+hNMvviJytg1UeX1W0fRGdvvl37PWeN9aruBF7BBSYRbm2iWypRbAz7sjLya4qbl9nW4MgM0Yp+jI+Bec2VSrBvaV8Zruy23b8g13KFPlxUEtsvKuYDNJfPks1Bko4=" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=debug msg="completed challenge" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30:18+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:18 bcik go-librespot[23958]: time="2026-10-14T12:30: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 14 12:30:18 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:18 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::volumioGetBrowseSources Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 12:30:19 bcik volumio[23544]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 14 12:30:19 bcik volumio[23544]: info: Completed starting MyVolumio Plugin Oct 14 12:30:19 bcik volumio[23544]: [Metrics] CommandRouter: 30s 934.00ms Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::volumiosetStartupVolume Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::Close All Modals sent Oct 14 12:30:19 bcik volumio[23544]: info: CoreCommandRouter::Close All Modals sent Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 14 12:30:20 bcik volumio-remote-updater[9031]: Test mode disabled Oct 14 12:30:20 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 14 12:30:20 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 14 12:30:20 bcik volumio[23544]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 12:30:20 bcik volumio[23544]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 14 12:30:20 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:20 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:21 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10114. Oct 14 12:30:21 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:21 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:21 bcik go-librespot[23989]: go-librespot daemon starting... Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+02:00" level=debug msg="app state loaded" Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+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 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+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 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+02:00" level=info msg="zeroconf server listening on port 45643" Oct 14 12:30:21 bcik go-librespot[23990]: time="2026-10-14T12:30:21+02:00" level=debug msg="obtained new client token: AAFTnubEtGeru4xwlmINAakKFcegA20D/7g1ecOgKb8NAHnP/oP3gpmfBgVwfbV1EzuqdFluwhRTnfTGD5kU/VP8N1X+b2877dToC0vyqkekv1tmUfgVaLA/Igt7Zi0ySqniIvq2f2uVnT5CY2Nxk5aLVO/ym/pgmZWh9dSZkhGnKplgCg5UBzKH23SSJrT6bgzGkTMU/VdChqyKz9J4QQv+JvMkCy9dw8Es6iqjg5G7AOuNd5uEsn0=" Oct 14 12:30:22 bcik go-librespot[23990]: time="2026-10-14T12:30:22+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:22 bcik go-librespot[23990]: time="2026-10-14T12:30:22+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:22 bcik go-librespot[23990]: time="2026-10-14T12:30:22+02:00" level=debug msg="completed challenge" Oct 14 12:30:22 bcik go-librespot[23990]: time="2026-10-14T12:30:22+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:22 bcik go-librespot[23990]: time="2026-10-14T12:30: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 14 12:30:22 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:22 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:23 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:23 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:25 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10115. Oct 14 12:30:25 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:25 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:25 bcik go-librespot[23999]: go-librespot daemon starting... Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="app state loaded" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+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 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+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 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=info msg="zeroconf server listening on port 45615" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="obtained new client token: AAH+B2Ksy6UhqwLMtZQMr+7jhKe0RXD4uOVB1FXXwJE8DCl0PK16h9IAdwA1CEwM7+P/6nqhJvjrO37M7lgaesqstaBzF0kDI0Xb/Nc5ViXhp3CXBWkk6t5aBP7a/x9jn/7HEXSt7x2tZ/DTiOD3C2tZzAEsEuxLgHeOsqnqM7kP7MgO7SrrRyO1+ejfKv2eEdU1OIKJKCGHyXnViST6RRoTkhFyGC5NRVw0uy4toF4OKEx/hXMouU4=" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=debug msg="completed challenge" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30:25+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:25 bcik go-librespot[24000]: time="2026-10-14T12:30: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 14 12:30:25 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:25 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:26 bcik volumio[23544]: info: BOOT COMPLETED Oct 14 12:30:26 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:26 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:28 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10116. Oct 14 12:30:28 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:28 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:28 bcik go-librespot[24009]: go-librespot daemon starting... Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+02:00" level=debug msg="app state loaded" Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+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 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+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 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+02:00" level=info msg="zeroconf server listening on port 35217" Oct 14 12:30:28 bcik go-librespot[24010]: time="2026-10-14T12:30:28+02:00" level=debug msg="obtained new client token: AAFzY4wkWpCLMPuUw1K9I/pCbg37pfOzznEa7gTUSEqZ58uVppszW5zG9sJttSfxcJcVsYgbTRwQhW1Gm/cTgFPJ9vJV36eZhvqYK/Pp7fRZwCGJtQjYvFV2wdH9nmXvoB7HFMSOibMFJbzxbrvyJDt9Z/fSc/wKtlgBJxGidHBsdTbugBkZf+aweupl1vXMaFStuzpTeFUMmO+7+x6gsJjMetEcr1Nw5qRh9gXHrdmiQuQJUnvJdO8=" Oct 14 12:30:29 bcik go-librespot[24010]: time="2026-10-14T12:30:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:29 bcik go-librespot[24010]: time="2026-10-14T12:30:29+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:29 bcik go-librespot[24010]: time="2026-10-14T12:30:29+02:00" level=debug msg="completed challenge" Oct 14 12:30:29 bcik go-librespot[24010]: time="2026-10-14T12:30:29+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:29 bcik go-librespot[24010]: time="2026-10-14T12:30: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 14 12:30:29 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:29 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:29 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:29 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:32 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10117. Oct 14 12:30:32 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:32 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:32 bcik go-librespot[24032]: go-librespot daemon starting... Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=debug msg="app state loaded" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30: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-gew1.spotify.com:80]" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+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 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+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 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=info msg="zeroconf server listening on port 33785" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=debug msg="obtained new client token: AAEqXxwoYMtTG1bPsQYMzROokSDHsoJOr5LBIPc71tr9/BvkSfQzZ2vuokKadvF3+uBuIwwYUFKdptdikPR9viTmXCGYy0syfECK13XLHMbg2h0QFUhGG89qwCO/Mh/dQEnqBva35Il17Y1I+ROMkyuZ3sRxY3wIMX2c7i9tGNtgpRFnlBCRkBCUJ6l559SnM1HpT2XEIjP05Pke7t1ViyxBzZY/iW/OdCkpNlCPHSUPe907WZ3WJuM=" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=debug msg="completed challenge" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30:32+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:32 bcik go-librespot[24033]: time="2026-10-14T12:30: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 14 12:30:32 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:32 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:32 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:32 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:35 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:35 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:35 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10118. Oct 14 12:30:35 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:35 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:35 bcik go-librespot[24043]: go-librespot daemon starting... Oct 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+02:00" level=debug msg="app state loaded" Oct 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+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 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+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 14 12:30:35 bcik go-librespot[24044]: time="2026-10-14T12:30:35+02:00" level=info msg="zeroconf server listening on port 40639" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30:36+02:00" level=debug msg="obtained new client token: AAHUdcP+hIYqMuaAyp3qZJyftotETQBhp6b02M4m6vGCsOCeMVt9rwMkI0zTGZ/W4oQH1uJM7Zyp3fPgIk4XGAW+JepEcAmo3njWE1StQ6f6z7B5aHUbWuE+hlxizX8W32t7n+1lPYNZUVN0juampp3ZhoeIhU8apievb+iJ8M99K9yTt4Z3M1u+VTsGMEKxRzRJz+710VKJGDSZ74htiMIPKCXIGx6kSbjU92rBDS97qhUFaMMkuXw=" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30:36+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30:36+02:00" level=debug msg="completed challenge" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30:36+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:36 bcik go-librespot[24044]: time="2026-10-14T12:30: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 14 12:30:36 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:36 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:38 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:38 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:39 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10119. Oct 14 12:30:39 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:39 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:39 bcik go-librespot[24067]: go-librespot daemon starting... Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=debug msg="app state loaded" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+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 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+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 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=info msg="zeroconf server listening on port 46097" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=debug msg="obtained new client token: AAH0zg0zL6eMPdSZggWcJdBIRmoo34CoceSsHiBrbDfchMekVW4WjGHfLwA8fOQWl3SSl2l0YIhvyw47DY98uwyWhsF1hl2fhXflBuzA4CFZMOTgYJBw7LTPjq7HHlHSM8nTe/mOrVBF/TE+cffILxbfoSl4ID+Vyp065J41UyYJo/Hv/YyZTcNAaDxKp6lj0/+8BvTQht2X4BR0rO65R+PSDb03wtkaflUoA5rJk88550PbnBNhZ1M=" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=debug msg="completed challenge" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30:39+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:39 bcik go-librespot[24068]: time="2026-10-14T12:30: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 14 12:30:39 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:39 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:41 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:41 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:42 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10120. Oct 14 12:30:42 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:42 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:42 bcik go-librespot[24078]: go-librespot daemon starting... Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+02:00" level=debug msg="app state loaded" Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+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 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+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 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+02:00" level=info msg="zeroconf server listening on port 38555" Oct 14 12:30:42 bcik go-librespot[24079]: time="2026-10-14T12:30:42+02:00" level=debug msg="obtained new client token: AAHESG/6NtJTxrCzOMi7j+twDE2rTxF+OQ01ayXw0vfhNMOysYJlha8zp+1oIRz7pFhuKNBoc1BxFVnL4btHOJ8RP1EX1gVItEyVQ1NbkVWZeqa9KBQmlMehsViG5KDzxDyotKOjlpPKcVM9+blWxpq8f5vAkSDbdnbTahGK4Bx/abn4MndHAEW3kujjflXUzxkI4Hbtl23QM/uS+D/FGBx79o+co+e4DOGg+nAA6kKo6fJqJYjOb3w=" Oct 14 12:30:43 bcik go-librespot[24079]: time="2026-10-14T12:30:43+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:43 bcik go-librespot[24079]: time="2026-10-14T12:30:43+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:43 bcik go-librespot[24079]: time="2026-10-14T12:30:43+02:00" level=debug msg="completed challenge" Oct 14 12:30:43 bcik go-librespot[24079]: time="2026-10-14T12:30:43+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:43 bcik go-librespot[24079]: time="2026-10-14T12:30: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 14 12:30:43 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:43 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:44 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:44 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:46 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10121. Oct 14 12:30:46 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:46 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:46 bcik go-librespot[24088]: go-librespot daemon starting... Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=debug msg="app state loaded" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30: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-gew1.spotify.com:80]" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+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 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+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 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=info msg="zeroconf server listening on port 39537" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=debug msg="obtained new client token: AAFQDgtZX33sN1LSk3QFWi9znQvLawDF0hqGbdxk00YBIH7l9KXbDHJHgsEfq4GrhiwNv7hf+Xvj83EEI4F0tYJ+KN+8B2baLIeACez+GKtQmw2klORLFjrzmzZ0uJegLw+9etk7JdZziOrpkZ00V0K13kvROqVuesdRTxfH2clAigIBcbbZJSh4wGYHiadNiUCPRS8b/ZvYU5jrJArn0vCzqrEIdFaLz3+RNt6uFHHliWK9BfjVV38=" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=debug msg="completed challenge" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30:46+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:46 bcik go-librespot[24089]: time="2026-10-14T12:30: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 14 12:30:46 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:46 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:47 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:47 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:49 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10122. Oct 14 12:30:49 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:49 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:49 bcik go-librespot[24112]: go-librespot daemon starting... Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+02:00" level=debug msg="app state loaded" Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+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 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+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 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+02:00" level=info msg="zeroconf server listening on port 40697" Oct 14 12:30:49 bcik go-librespot[24113]: time="2026-10-14T12:30:49+02:00" level=debug msg="obtained new client token: AAHnk8DAhnqtSeVVwN0pleQGxv9S7ARq62LI6fbSxp0KLjIrKR6uB1N/IIR51oL3KOjtmwVB8SgGNkGhgmuVrcn/JaRWa4Mg5HkZQL7tyJt41N/OaZXi9KJQ/xg/JkR+PBPQdf7QYRuKls2CZeRLB4zrvvDuWn8EauLbAFWesUvTMNiVplZDUZJAHqkgXVG+FzTpMV4Dm7KE+N8QF3NKxEW1m35+hVLT24mKsLM4+sPc3O0i3r3u7GQ=" Oct 14 12:30:50 bcik go-librespot[24113]: time="2026-10-14T12:30:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:50 bcik go-librespot[24113]: time="2026-10-14T12:30:50+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:50 bcik go-librespot[24113]: time="2026-10-14T12:30:50+02:00" level=debug msg="completed challenge" Oct 14 12:30:50 bcik go-librespot[24113]: time="2026-10-14T12:30:50+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:50 bcik go-librespot[24113]: time="2026-10-14T12:30: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 14 12:30:50 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:50 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:50 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:50 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:53 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10123. Oct 14 12:30:53 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:53 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:53 bcik go-librespot[24122]: go-librespot daemon starting... Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="app state loaded" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+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 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+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 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=info msg="zeroconf server listening on port 41185" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="obtained new client token: AAE5XKnc5lOipOWR1dJ9jkKffKBWTOaYFzzMaKVwirxQHicVZWeJXnCkn8KhGgr2o8RuUpZzR8tI+YBL97nZdOzrKXLbXlZmCDCcoMWmsOkrhxBYSXu/OYR9yzio2xVmELJQ8+3F9ssPil9FFk14RZo+FTNi48vRCKTy+HxhvtYhztkJEpgAiCYBFLROULjXM/UWaEVpRdCZAlPT+miGR9dS7Nx2if2nmfjBVSs+pOr6K+BHu+8e/uU=" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=debug msg="completed challenge" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30:53+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:53 bcik go-librespot[24123]: time="2026-10-14T12:30: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 14 12:30:53 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:53 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:53 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:53 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:56 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:56 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:30:56 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10124. Oct 14 12:30:56 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:56 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:30:56 bcik go-librespot[24132]: go-librespot daemon starting... Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+02:00" level=debug msg="app state loaded" Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30: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-gew1.spotify.com:80]" Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+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 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+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 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+02:00" level=info msg="zeroconf server listening on port 41023" Oct 14 12:30:56 bcik go-librespot[24133]: time="2026-10-14T12:30:56+02:00" level=debug msg="obtained new client token: AAFKNwaeoFKUuhhDWuTL8BqL30c8RH8P4tTsW08F2YgHbGXvPF3sfM99D55AH2tx+6KE+OOeZ2mqnAMX8p/H621pWgIeR0kU2HSpwGSuw97IC4OPHKj7FjeTPrjIyP5GoTYIQy/1FXyf/XULq3STRg6njzFLjuocmf0BSKq7y0x2NUGtZxTrucNPlU9TeYyFfzJSc12E5wGrL5J6hVwlPZidHzjhv8GsOWS6OmoGVoTX+uyG6YwQU+8=" Oct 14 12:30:57 bcik go-librespot[24133]: time="2026-10-14T12:30:57+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:30:57 bcik go-librespot[24133]: time="2026-10-14T12:30:57+02:00" level=debug msg="completed keyexchange" Oct 14 12:30:57 bcik go-librespot[24133]: time="2026-10-14T12:30:57+02:00" level=debug msg="completed challenge" Oct 14 12:30:57 bcik go-librespot[24133]: time="2026-10-14T12:30:57+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:30:57 bcik go-librespot[24133]: time="2026-10-14T12:30: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 14 12:30:57 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:30:57 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:30:59 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:30:59 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:00 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10125. Oct 14 12:31:00 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:00 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:00 bcik go-librespot[24156]: go-librespot daemon starting... Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=debug msg="app state loaded" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31: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 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31: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 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31: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 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=info msg="zeroconf server listening on port 37647" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=debug msg="obtained new client token: AAHJPQ+f0ezQC9iBbJE9d5TGCi8GukQIT3RUKeJdZbMo4xHf+DtpvPngdXTY9lX/CLqnLLby/pDJvmUhTMbJgXz4kRrZAX8qgeMCbQXSXTVQ1NfFQmz1P/Ld0n3vOkPmXwen7ldKEku2pE64jtMOILVZYouejaqdTGEo6SeRn0Bzvt0MlsBRet320arSMf9cOrxAEChTu8B0RpHLhrIxUxGseIAQWb3mXctzfEEVN9IgKa2pt6xpSV0=" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=debug msg="completed keyexchange" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=debug msg="completed challenge" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31:00+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:31:00 bcik go-librespot[24157]: time="2026-10-14T12:31: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 14 12:31:00 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:31:00 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:31:02 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:31:02 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:03 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10126. Oct 14 12:31:03 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:03 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:03 bcik go-librespot[24167]: go-librespot daemon starting... Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+02:00" level=debug msg="app state loaded" Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+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 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+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 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+02:00" level=info msg="zeroconf server listening on port 35099" Oct 14 12:31:03 bcik go-librespot[24168]: time="2026-10-14T12:31:03+02:00" level=debug msg="obtained new client token: AAFaygIpLVDakNpEKtJ/8zpKBIEIq1pJ11+ufH2sx6pTkDu37KT2dv1giOpYsbftP/3v5A1Drba076XMcXpr1/kDYJ9TpQsj+c0a68z8JqGleaKttJ9JU8En2N8iC/hWKPLveIwGRo+joWMFdpjD1Vp7IdCuCEDITUM8veMSmb6J0ndGfrhFRcuIN6/Kecu8mnO/X5wUH7agmR0hCN/jpyQFbCX+kp4YEo10fzbjTt8ni206+7jITjA=" Oct 14 12:31:04 bcik go-librespot[24168]: time="2026-10-14T12:31:04+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:31:04 bcik go-librespot[24168]: time="2026-10-14T12:31:04+02:00" level=debug msg="completed keyexchange" Oct 14 12:31:04 bcik go-librespot[24168]: time="2026-10-14T12:31:04+02:00" level=debug msg="completed challenge" Oct 14 12:31:04 bcik go-librespot[24168]: time="2026-10-14T12:31:04+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:31:04 bcik go-librespot[24168]: time="2026-10-14T12:31: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 14 12:31:04 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:31:04 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:31:05 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:31:05 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:07 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10127. Oct 14 12:31:07 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:07 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:07 bcik go-librespot[24177]: go-librespot daemon starting... Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=debug msg="app state loaded" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+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 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+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 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=info msg="zeroconf server listening on port 35631" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=debug msg="obtained new client token: AAH7vKxJtVWOCYZRGTgQ+DlZSaGZ1EdQcQ4p5/YQEmUmrE4dywFsnxPK1wKf/Rhtsf+bgNCwpRsE5S5IrSJKf4tlUXzbNLk2qLXvsmhXFetaS6n9VHsI4+vj11FRlF3QF7e32Jb2HlPqx4Okl/fD88nd5ZqR4mocy5aJRNW0XibV84r8IXiHeUZURaJy+S9/KCIey4RcO/4btWWU3vn4iW6PHg+9LflFj3Y3hY/Pr3meQqNjqunAOfU=" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=debug msg="completed keyexchange" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=debug msg="completed challenge" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31:07+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:31:07 bcik go-librespot[24178]: time="2026-10-14T12:31: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 14 12:31:07 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:31:07 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:31:08 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:31:08 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:10 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10128. Oct 14 12:31:10 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:10 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:10 bcik go-librespot[24201]: go-librespot daemon starting... Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+02:00" level=debug msg="app state loaded" Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+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 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+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 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+02:00" level=info msg="zeroconf server listening on port 42579" Oct 14 12:31:10 bcik go-librespot[24202]: time="2026-10-14T12:31:10+02:00" level=debug msg="obtained new client token: AAG34mRKM3TvB7olyJuDmQ9R+7DtVgSz3ydUsTbmLY/pGW3rb9qgp6Tkgv2KvYvXNJDB3TTVQomTPKIFBBXwUBb/xoono7iNgUbdtZqVR6dsy13VIXkohNgYedFFohFFzsF5D7Noc/7Nj2vREnN406Dcz6At1zhWl43bwtIDIKlhmVJdSWmLJsUc0TUOIH+3GO/cXrfoh8WQbBtbmmakcHD+y7sLMxztxZuQgSUy+82+0Pi0sp/Izog=" Oct 14 12:31:11 bcik go-librespot[24202]: time="2026-10-14T12:31:11+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:31:11 bcik go-librespot[24202]: time="2026-10-14T12:31:11+02:00" level=debug msg="completed keyexchange" Oct 14 12:31:11 bcik go-librespot[24202]: time="2026-10-14T12:31:11+02:00" level=debug msg="completed challenge" Oct 14 12:31:11 bcik go-librespot[24202]: time="2026-10-14T12:31:11+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:31:11 bcik go-librespot[24202]: time="2026-10-14T12:31: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 14 12:31:11 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:31:11 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:31:11 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:31:11 bcik volumio[23544]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:14 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10129. Oct 14 12:31:14 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:14 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:14 bcik go-librespot[24211]: go-librespot daemon starting... Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="app state loaded" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31: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 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31: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 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31: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 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=info msg="zeroconf server listening on port 45045" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="obtained new client token: AAHPCMaW5ZSgpqyBYWvjIhCLn4OyN+k4jhgDTje7hrhQQu/WuVSksq4eNmwW5m/3UEZHg0K0E2G186JxkzJ9mrhWvKZ7JHa+WIVHIuixLxIddGn78ZZOxNh3vy8/EF8zpxKXp7c6jPq6TjUR/v069vsNON6Sd/ue9mIaBMG8QqEYS4H831Hxuq2a1Os81Pzq/MvZgs5ZKYWejRgPvdEsUtdTBIOIB7TUbdwz1aRSOazuqz28vHVNz+Q=" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="completed keyexchange" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="completed challenge" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=info msg="authenticated AP" username="la***pl" Oct 14 12:31:14 bcik volumio[23544]: info: Initializing connection to go-librespot Websocket Oct 14 12:31:14 bcik volumio[23544]: info: Connection to go-librespot Websocket established Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31:14+02:00" level=debug msg="new websocket client" Oct 14 12:31:14 bcik go-librespot[24212]: time="2026-10-14T12:31: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 14 12:31:14 bcik volumio[23544]: info: Connection to go-librespot Websocket closed Oct 14 12:31:14 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:31:14 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 12:31:17 bcik volumio[23544]: info: Getting Spotify volume Oct 14 12:31:17 bcik volumio[23544]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 12:31:17 bcik volumio[23544]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 12:31:17 bcik volumio[23544]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 14 12:31:17 bcik volumio[23544]: errno: -111, Oct 14 12:31:17 bcik volumio[23544]: code: 'ECONNREFUSED', Oct 14 12:31:17 bcik volumio[23544]: syscall: 'connect', Oct 14 12:31:17 bcik volumio[23544]: address: '127.0.0.1', Oct 14 12:31:17 bcik volumio[23544]: port: 9879, Oct 14 12:31:17 bcik volumio[23544]: response: undefined Oct 14 12:31:17 bcik volumio[23544]: } Oct 14 12:31:17 bcik volumio[23544]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 12:31:17 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10130. Oct 14 12:31:17 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:17 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 12:31:17 bcik go-librespot[24233]: go-librespot daemon starting... Oct 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+02:00" level=info msg="running go-librespot 0.6.2" Oct 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+02:00" level=debug msg="app state loaded" Oct 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 12:31:17 bcik sudo[24243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 12:30' Oct 14 12:31:17 bcik sudo[24243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+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 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+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 14 12:31:17 bcik go-librespot[24234]: time="2026-10-14T12:31:17+02:00" level=info msg="zeroconf server listening on port 40331" 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"