Feb 09 21:23:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Feb 09 21:23:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:00 volumio go-librespot[7230]: go-librespot daemon starting... Feb 09 21:23:00 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 09 21:23:00 volumio go-librespot[7231]: time="2026-02-09T21:23:00-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:00 volumio go-librespot[7231]: time="2026-02-09T21:23:00-06:00" level=debug msg="app state loaded" Feb 09 21:23:00 volumio go-librespot[7231]: time="2026-02-09T21:23:00-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:00 volumio go-librespot[7231]: time="2026-02-09T21:23:00-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=info msg="zeroconf server listening on port 44415" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="obtained new client token: AADlm0oZE80Y3mkNX+x/gMXFzcRNV9BTFL38AKKZErQBxRpxziIT0JALKNXvVAaESazB1Lbg/Ony3vxun7NPHcNVZOBCCtllW+kVIDPC1IQPe80+nwbk72BwDGTa9urs9kOnHlIJTJrEb9+/aypMVpP6wDWHxORso76KFdtUfPmx/UzwoQ4MmErwdI2PK2CCW0mIQcbGWExOl/Qg8pZblcGATz4Qm1WV9rtFGHgIsKr4LtNISHjGYcw=" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:4070, retrying with a different AP" error="dial tcp 104.154.127.247:4070: connect: connection refused" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=debug msg="completed challenge" Feb 09 21:23:01 volumio go-librespot[7231]: time="2026-02-09T21:23:01-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:02 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 09 21:23:02 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 09 21:23:02 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:02 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::volumioGetBrowseSources Feb 09 21:23:03 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 09 21:23:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78. Feb 09 21:23:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:04 volumio go-librespot[7263]: go-librespot daemon starting... Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="app state loaded" Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:04 volumio volumio[6606]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 09 21:23:04 volumio volumio[6606]: info: Completed starting MyVolumio Plugin Feb 09 21:23:04 volumio volumio[6606]: [Metrics] CommandRouter: 56s 773.66ms Feb 09 21:23:04 volumio volumio[6606]: info: CoreCommandRouter::volumiosetStartupVolume Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:04 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:04 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 09 21:23:04 volumio volumio[6606]: info: CoreCommandRouter::Close All Modals sent Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=info msg="zeroconf server listening on port 38171" Feb 09 21:23:04 volumio volumio[6606]: info: CoreCommandRouter::Close All Modals sent Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="obtained new client token: AADnTX2Z47HtNXBV9mNf3BPwJEgSpocY2oIDuBI+N3Tu5msr1bYA0RM83O3r559IBToYGY0kN8+ys2YyHzBGxqzfl5jlgWzxRRlKsbJF9IyO5/0XfySx6NU3qWIMcYQxzQ8OkNyi6L6qcIoZwRRahTudElWLlkirk8YcvTxoMgz2M3I9XaOi5CWLmkev1wTU9oAZ5LinyjUqcPxZT7fp5VsCXWv6r3B4gWsHml0AM9+jObfremOzBHwz3Q==" Feb 09 21:23:04 volumio go-librespot[7264]: time="2026-02-09T21:23:04-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:05 volumio go-librespot[7264]: time="2026-02-09T21:23:05-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:05 volumio go-librespot[7264]: time="2026-02-09T21:23:05-06:00" level=debug msg="completed challenge" Feb 09 21:23:05 volumio go-librespot[7264]: time="2026-02-09T21:23:05-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:05 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 09 21:23:05 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 09 21:23:05 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 09 21:23:05 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:05 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79. Feb 09 21:23:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:08 volumio go-librespot[7277]: go-librespot daemon starting... Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="app state loaded" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=info msg="zeroconf server listening on port 34771" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="obtained new client token: AAAq/0rd7BhuPCEat+jM19Y63AxNzKy4PvQpoILqUIny7UrUFVSdy889vw52+2qAoeyVczGwbcRS6X7QypeC5r89kbp3xtR0mnzsZqOSx0sZIXnKv1NUUNisOOi4FuD0iv/0urERqbcJ6BzCBTCEaTsDpbNmFCwv4dqLoVjPvzA63Rd0D4jVvuf7HXf9Uh4e8ReyuoYDwqb9tbBO4QcvCvSnm1EdTx74CRuEB7NFR6mKAKTfaojLcc3d+w==" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=debug msg="completed challenge" Feb 09 21:23:08 volumio go-librespot[7278]: time="2026-02-09T21:23:08-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:08 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:08 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:11 volumio volumio[6606]: info: BOOT COMPLETED Feb 09 21:23:12 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:12 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80. Feb 09 21:23:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:12 volumio go-librespot[7301]: go-librespot daemon starting... Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="app state loaded" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=info msg="zeroconf server listening on port 42195" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="obtained new client token: AACRGRcVyGw6urzbolwE3ilqCZQIMEz+QSanL6rNxIWfeqBreX6Ekf8CX1r2/ZI51QcZ3uXpme+2PqkqCyhF0awSqb6cUR6XjjkxyzyNfVOzmi/nYGNt0VTWsTk1WZ8daVJqFzktNGYDjoEYvgyXLYDeIo1PXHeTtDlHl317pcInzla4CuHC5GmsBgdlSfq/esJvBXiKn866l9TXWELs3hF6ewPyAQD5Xefl6hNaWmsuRDaplxNxRz0RDQ==" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=debug msg="completed challenge" Feb 09 21:23:12 volumio go-librespot[7302]: time="2026-02-09T21:23:12-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:15 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:15 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81. Feb 09 21:23:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:15 volumio go-librespot[7309]: go-librespot daemon starting... Feb 09 21:23:15 volumio go-librespot[7310]: time="2026-02-09T21:23:15-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:15 volumio go-librespot[7310]: time="2026-02-09T21:23:15-06:00" level=debug msg="app state loaded" Feb 09 21:23:15 volumio go-librespot[7310]: time="2026-02-09T21:23:15-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:15 volumio go-librespot[7310]: time="2026-02-09T21:23:15-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=info msg="zeroconf server listening on port 38199" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="obtained new client token: AAD0WV97YJBRbezO9D9bo9/k2e8uiMopErtv2eLqYlWKkXNs1uBQLJTSGPwOq7KRzz/k+VXB3rqrCoWJgUd1nP4wivyxpKCIo015n3lQWLM2jiJaKVdIRacKtBu5BF4mU8LIR08nyO7fWJUdO3xrjFxC//rE5lq71JV3IsL7jM/K9zck8G+0nb3J0a8T277ZeONr+YG9tyVoq+iwOmi92dFfK40rbHccv7W6bAQndBVLx/3GBML1KDY=" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=debug msg="completed challenge" Feb 09 21:23:16 volumio go-librespot[7310]: time="2026-02-09T21:23:16-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:18 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:18 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Feb 09 21:23:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:19 volumio go-librespot[7321]: go-librespot daemon starting... Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="app state loaded" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=info msg="zeroconf server listening on port 40293" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=debug msg="obtained new client token: AAAcdemuf6U2LT9tNLRT3POCAghIxBVTKd6NCRt+yuUI0jIjjaQKMZ4Smy2Lr+6HM4ElPJ/0/3j0siTnb9YHTBjmZDjlZl7/BvWtpQRjKQ7wH8g2hor42zeQ2O7I7A97T4WnlvuqE1MlP2P6P2jK3rYQE/qHbmw7z2nysM9g+BbAB7XYqh4z+5y9rK1KgNxrLXSnH/hnFmzPzSSVRbtEKmk0Fs7bfFQ4ysB2D+MNl00SS2G7aoEhJ01enQ==" Feb 09 21:23:19 volumio go-librespot[7322]: time="2026-02-09T21:23:19-06:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:4070, retrying with a different AP" error="dial tcp 104.154.127.247:4070: connect: connection refused" Feb 09 21:23:20 volumio go-librespot[7322]: time="2026-02-09T21:23:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 09 21:23:20 volumio go-librespot[7322]: time="2026-02-09T21:23:20-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:20 volumio go-librespot[7322]: time="2026-02-09T21:23:20-06:00" level=debug msg="completed challenge" Feb 09 21:23:20 volumio go-librespot[7322]: time="2026-02-09T21:23:20-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:21 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:21 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Feb 09 21:23:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:23 volumio go-librespot[7343]: go-librespot daemon starting... Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="app state loaded" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=info msg="zeroconf server listening on port 42727" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="obtained new client token: AAClf8Ct6nvynXB45jEKfA4UTd06iosMnSdxCrZnAE17OwOTJmY6FlCq2LXUmO/qsbZhcBmXEBfXsoOfsI34l4JokuovSppCL/svoameIBV2/Xmz+7LRu/HfMfaSznRKU7jXnehXcUEMyVP0/bJs+pi44WGjdz0+cJkHJsoXT0WUnY3mhvUlU84SZWllnrh07RJ5zCNaHUF9on7r/bW2E5olA0+7FIAJ7sfoe9v/4pMGm4VSWIB6l2eFHg==" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=debug msg="completed challenge" Feb 09 21:23:23 volumio go-librespot[7344]: time="2026-02-09T21:23:23-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:24 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:24 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:26 volumio volumio[6606]: info: UPDATER: Scheduling automatic update Feb 09 21:23:26 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime Feb 09 21:23:26 volumio volumio[6606]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime Feb 09 21:23:26 volumio volumio[6606]: info: UPDATER: Auto update will take place at: Tue Feb 10 2026 03:07:37 GMT-0600 (Central Standard Time) Feb 09 21:23:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Feb 09 21:23:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:27 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:27 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:27 volumio go-librespot[7351]: go-librespot daemon starting... Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="app state loaded" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=info msg="zeroconf server listening on port 43123" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="obtained new client token: AACRxy7rog8Dm5sWiyksH6ykvM7Lxj+EWvXQVpknMiFnJomLm9itDQhP/mVO3stGXH7SN9oCBxCBgubgeL3eY0UhD4hbFrb7rbRF+h0BP2J0a1yYZb+y7YH+KlPhf4X7ZUqD4yW5PXx3h1sSeEg5+HyVUd3yTR4AvRoikzikuhJFWMTuYigSOCPFF0qXM3KOp9UT5ouTsI4HWhAm4TArEghzghPIdYjrEL4PwExarzWYNBiULZJt7EmGyg==" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=debug msg="completed challenge" Feb 09 21:23:27 volumio go-librespot[7352]: time="2026-02-09T21:23:27-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:30 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:30 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Feb 09 21:23:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:30 volumio go-librespot[7375]: go-librespot daemon starting... Feb 09 21:23:30 volumio go-librespot[7376]: time="2026-02-09T21:23:30-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:30 volumio go-librespot[7376]: time="2026-02-09T21:23:30-06:00" level=debug msg="app state loaded" Feb 09 21:23:30 volumio go-librespot[7376]: time="2026-02-09T21:23:30-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:30 volumio go-librespot[7376]: time="2026-02-09T21:23:30-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=info msg="zeroconf server listening on port 33121" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="obtained new client token: AADO7x6rPwm1t4MtEcn70iYTgZWdZEe/nao1YHzxWauWNROEfMnA8pXp6HL+An34SBK/Q3YHp4J+AMPptjJV4Z0tlx2lbBHW4BxusxvbmcQYIS5YcLcosB2NCaWOEOZ33X4L4Kws0CTsigEOYtfM2Uxu9SCTyu4JgWw2AA8SWLoe43KipSDNc8h94MnE+qE6JDGd9PHSVLK8ESfpRMnehTdKYA8C7TmuhIM5K0eOq06YabxedBuBXBU=" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=debug msg="completed challenge" Feb 09 21:23:31 volumio go-librespot[7376]: time="2026-02-09T21:23:31-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:33 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:33 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Feb 09 21:23:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:34 volumio go-librespot[7383]: go-librespot daemon starting... Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="app state loaded" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=info msg="zeroconf server listening on port 38347" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="obtained new client token: AABJ2wPSHcLrI348/J7yA52a3lqSfgYWe6apRhQ/OLhfQPVzoCisWGUmcx3uarEYeOa49mx5l3r3Za7N7ffuZvurHfsITAEpIirrNWqSginzk21dRDw6l7ydzuyHAr4aN6UjAcbF71Z06wdZRjOHyMArk2i3Zdilh+GC2myAnW8JQQ4kGhpZlfUEqOXIQegYqjN6kJoigXGUPK7iXyMP/GyMACBI+XqSHWPQwTBngTY4aDv4unFxnJQ1qA==" Feb 09 21:23:34 volumio go-librespot[7384]: time="2026-02-09T21:23:34-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:35 volumio go-librespot[7384]: time="2026-02-09T21:23:35-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:35 volumio go-librespot[7384]: time="2026-02-09T21:23:35-06:00" level=debug msg="completed challenge" Feb 09 21:23:35 volumio go-librespot[7384]: time="2026-02-09T21:23:35-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:36 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:36 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Feb 09 21:23:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:38 volumio go-librespot[7394]: go-librespot daemon starting... Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="app state loaded" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=info msg="zeroconf server listening on port 45025" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="obtained new client token: AABMPvngahOyD/645sw89bfLX2L/VFMid29HV7vqKkpJ+Mr87nigxCYSxAK/ubUtmX14PQp7ZTqF7ALupgzzmxaBMpTvp61lojwFu/h/9AjgvQ+CQWNtSa/rXDNTT5GStxCxKcOFptbaQFH7hrkrnMKbDQzkZ9kWHB/KxKTeS2FpCUmLUXuvjtvOSN7sbW7rhs7pr8OHncNSax/CBpync4Rl4lvB2qZA+yz/mHed9YHeDjp7cvl62OTKCw==" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=debug msg="completed challenge" Feb 09 21:23:38 volumio go-librespot[7395]: time="2026-02-09T21:23:38-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:39 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:39 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Feb 09 21:23:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:42 volumio go-librespot[7416]: go-librespot daemon starting... Feb 09 21:23:42 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:42 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="app state loaded" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=info msg="zeroconf server listening on port 46669" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="obtained new client token: AAA4WHHwr7b/Wx3V2FueRlbjPLk4x2TubsEPdSjvarrQcvd0xKQUbqdekE3nPH7UC8S+hm2BjHd8A5pm1q2V4+VzKn6D8qp5LaYeZITx7NB19ERPDO6cWCvao1bNcRh7FqL4iqx43qUgPtDICQbjgOrRpSBONqA1Ah4nCqW/UEYo2RHENWRENlEQ/x8+hgN/JP4IbYwqsVzym/44fIPTkV0QyPJC75ZPx6ZbsvE/2uPQY6chc7442tFq6w==" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=debug msg="completed challenge" Feb 09 21:23:42 volumio go-librespot[7417]: time="2026-02-09T21:23:42-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:45 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:45 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Feb 09 21:23:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:45 volumio go-librespot[7424]: go-librespot daemon starting... Feb 09 21:23:45 volumio go-librespot[7425]: time="2026-02-09T21:23:45-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:45 volumio go-librespot[7425]: time="2026-02-09T21:23:45-06:00" level=debug msg="app state loaded" Feb 09 21:23:45 volumio go-librespot[7425]: time="2026-02-09T21:23:45-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:45 volumio go-librespot[7425]: time="2026-02-09T21:23:45-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=info msg="zeroconf server listening on port 36729" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="obtained new client token: AAAMFvmQe7Q7lWjDqpxM6bIPNy1QvxhInNAvhXSVezvkkzNIeDo8udwmFK0MrVbBaU1smWuSGNTkXfGtwTcBLGFiMhz9TAaWbDsb+mlNQ/rLq7E4TUpyjnxxmuYtcti1IAs9gZ71pHfcNGetKoM0/GKcbtjkFqFKYosMXtGDY9d4WhsYhnorMoxMjymn4HGcNtKmDxaVnBzK2puybowF4JcCRWtfvhhZqOQf7VbOfzERjsf0RHqdrTw=" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=debug msg="completed challenge" Feb 09 21:23:46 volumio go-librespot[7425]: time="2026-02-09T21:23:46-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:48 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:48 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90. Feb 09 21:23:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:49 volumio go-librespot[7433]: go-librespot daemon starting... Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="app state loaded" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=info msg="zeroconf server listening on port 44353" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="obtained new client token: AADXMJxPnRupcJAEaxqQSvLJO3PaDfbnKW5lhSaUkNNOiU0tFh0KYW8WbQva/LnKRwHxirIS8SJocwHpC5QBIBYK/BkBnhezq0Hkdgi8Qi+hjSBkepm9U851qhUB/qMddAvqI+opJnEhSxTdVt24a3WxAx75IGYglHoP5gbdceOW2JiG3BKyfB9OXt7Tpfnt8XwxxMNzcLsRiSqQ+fiSP9oG4d3i8c4NJXLDNwPOzIwvg5N06CB0g4GQyA==" Feb 09 21:23:49 volumio go-librespot[7434]: time="2026-02-09T21:23:49-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:50 volumio go-librespot[7434]: time="2026-02-09T21:23:50-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:50 volumio go-librespot[7434]: time="2026-02-09T21:23:50-06:00" level=debug msg="completed challenge" Feb 09 21:23:50 volumio go-librespot[7434]: time="2026-02-09T21:23:50-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:51 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:51 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91. Feb 09 21:23:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:53 volumio go-librespot[7455]: go-librespot daemon starting... Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="app state loaded" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=info msg="zeroconf server listening on port 43479" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="obtained new client token: AACQbMJAby/U63YBlVcYkyoU1TrImBYry2nJ/oxkAv5C59tDgzJWLzmhVd6lCTAAk1AdyookgvzBoyLHOF4RDDxF8BN7xJ45ldFvyxf3gDohISU5ub4RFxrVR5Vzf58vbEWgz6s0SYBRbeHFmJ28f4gFhWTOg9avjJYwuXEgTj6axUiR2m+JtOIwJVAnbMCjv3AZdw/AKmOlbajFf27gX+3nWRB3XJ20RJu/nPeCI3OgRM1gcTI+XQ88Uw==" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=debug msg="completed challenge" Feb 09 21:23:53 volumio go-librespot[7456]: time="2026-02-09T21:23:53-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:54 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:54 volumio volumio[6606]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:23:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92. Feb 09 21:23:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:23:57 volumio go-librespot[7466]: go-librespot daemon starting... Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="app state loaded" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="stored credentials not found" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:23:57 volumio volumio[6606]: info: Initializing connection to go-librespot Websocket Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="new websocket client" Feb 09 21:23:57 volumio volumio[6606]: info: Connection to go-librespot Websocket established Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=info msg="zeroconf server listening on port 36153" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="obtained new client token: AAAZgqj5864H2GaYDS2/9aPN01rkuIHKlvE91HUYHxQ8SOI7g9oCRf86UYlUSW463IQ66nWieTnVQSxnzkdcM3zM1AGXNfEXsLjbok4fp1cTN7p8oarLHIZx0UHrhN3DeKVckmnURp9Onemch4kPg6hpoXmTdkiuHHFUAUeSM8lN47u2+ugsraeWOFCtFd8FOiHkS6lFq/eoR5uBMP4PesGiHvsfLFbO3386YjB5o2mLMKPyDc86UoyFYA==" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="completed keyexchange" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=debug msg="completed challenge" Feb 09 21:23:57 volumio go-librespot[7467]: time="2026-02-09T21:23:57-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 09 21:23:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 09 21:23:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 09 21:23:57 volumio volumio[6606]: info: Connection to go-librespot Websocket closed Feb 09 21:24:00 volumio volumio[6606]: info: Getting Spotify volume Feb 09 21:24:00 volumio volumio[6606]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 09 21:24:00 volumio volumio[6606]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 09 21:24:00 volumio volumio[6606]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 09 21:24:00 volumio volumio[6606]: errno: -111, Feb 09 21:24:00 volumio volumio[6606]: code: 'ECONNREFUSED', Feb 09 21:24:00 volumio volumio[6606]: syscall: 'connect', Feb 09 21:24:00 volumio volumio[6606]: address: '127.0.0.1', Feb 09 21:24:00 volumio volumio[6606]: port: 9879, Feb 09 21:24:00 volumio volumio[6606]: response: undefined Feb 09 21:24:00 volumio volumio[6606]: } Feb 09 21:24:00 volumio volumio[6606]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 09 21:24:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Feb 09 21:24:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:24:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 09 21:24:00 volumio go-librespot[7500]: go-librespot daemon starting... Feb 09 21:24:00 volumio go-librespot[7501]: time="2026-02-09T21:24:00-06:00" level=info msg="running go-librespot 0.4.0" Feb 09 21:24:00 volumio go-librespot[7501]: time="2026-02-09T21:24:00-06:00" level=debug msg="app state loaded" Feb 09 21:24:00 volumio go-librespot[7501]: time="2026-02-09T21:24:00-06:00" level=debug msg="stored credentials not found" Feb 09 21:24:00 volumio go-librespot[7501]: time="2026-02-09T21:24:00-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 09 21:24:00 volumio sudo[7509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-09 21:23' Feb 09 21:24:00 volumio sudo[7509]: 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="ac7dd5922ede329d1459d48b226ddc71f5209a2c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Nov 13 11:04:27 UTC 2025" VOLUMIO_VERSION="4.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7da8d6d9f8baf8621af4ec2af5a00f00"