Feb 24 22:36:00 volumio volumio[28169]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 24 22:36:00 volumio volumio[28169]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 24 22:36:00 volumio volumio[28169]: info: Streaming services startup
Feb 24 22:36:00 volumio volumio[28169]: info: Starting Streaming Daemon
Feb 24 22:36:00 volumio sudo[28668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 24 22:36:00 volumio sudo[28668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 22:36:00 volumio volumio[28169]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 24 22:36:00 volumio sudo[28668]: pam_unix(sudo:session): session closed for user root
Feb 24 22:36:00 volumio volumio[28169]: error: Cannot start Volumio Streaming Daemon
Feb 24 22:36:00 volumio volumio[28169]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 24 22:36:00 volumio volumio[28169]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 24 22:36:00 volumio volumio[28169]: error: MyVolumio FAILED LOGIN: Invalid assertion format. 3 dot separated segments required.
Feb 24 22:36:00 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:00 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65.
Feb 24 22:36:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:00 volumio go-librespot[28674]: go-librespot daemon starting...
Feb 24 22:36:00 volumio go-librespot[28675]: time="2026-02-24T22:36:00-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:00 volumio go-librespot[28675]: time="2026-02-24T22:36:00-06:00" level=debug msg="app state loaded"
Feb 24 22:36:00 volumio go-librespot[28675]: time="2026-02-24T22:36:00-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:00 volumio go-librespot[28675]: time="2026-02-24T22:36:00-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-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 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-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 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-06:00" level=info msg="zeroconf server listening on port 46721"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-06:00" level=debug msg="obtained new client token: AACgWnu7xLUrYsNeZPItk/+lnMdERThpTHXHYG3DLQGDjdqq2yzWzDJaXOb5T4Je7y4+6eJjuDbWtXownbzUBiXoisagq5Ngo5+apy5jEllpJXcrOKKukWY7nx2tJ+24YrBEBLltPpT0hkiBtA+qYdD8Ns+OylBKP1eKzYXnk/wuQ9itGXgVPUi3FepPB8O/EZbvlIF/dLASBhQD8ey8QzLJliH9sxYtMBRfx6HTMEWzsbiRJPUQWVMB9g=="
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36:01-06:00" level=debug msg="completed challenge"
Feb 24 22:36:01 volumio go-librespot[28675]: time="2026-02-24T22:36: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 24 22:36:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:03 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:03 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66.
Feb 24 22:36:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:04 volumio go-librespot[28682]: go-librespot daemon starting...
Feb 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36:04-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36:04-06:00" level=debug msg="app state loaded"
Feb 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36:04-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36:04-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36: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 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36: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 24 22:36:04 volumio go-librespot[28683]: time="2026-02-24T22:36: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 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36:05-06:00" level=info msg="zeroconf server listening on port 35085"
Feb 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36:05-06:00" level=debug msg="obtained new client token: AACw1AKqjzvMChoO7FNMe+uhDZu7dPNB+Xa7XHsfR5VOPO7LGWcjbAAAYOlJsUeO+wy31wqcNIioq270utBoFS9Z5S32sE7LjiwKL+xtn/DKbgSMZBhG7ft8CH/wynq/g7R/KukOqO6I9A5BBiIgKbID4gvZ/hBbaO8tpTf+D/xLAdmBSYUSUyevAtmQ0H2sn+6YcrhMGddpiFay/T+n2bg2tj0fveZ4yueR+S0jEKyqVDf/ogZdl2o="
Feb 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36:05-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36:05-06:00" level=debug msg="completed challenge"
Feb 24 22:36:05 volumio go-librespot[28683]: time="2026-02-24T22:36: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 24 22:36:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:06 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:06 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67.
Feb 24 22:36:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:08 volumio go-librespot[28705]: go-librespot daemon starting...
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="app state loaded"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36: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 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36: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 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36: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 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=info msg="zeroconf server listening on port 35433"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="obtained new client token: AABEffJn+sygb7RW2Zwd/UTQpid1y+FEq9tv+Rd7cx9i98OosE3dJG6ve+jkCiMhS64k9eiEwDZ6Ob7BnXh+vH0ZeRqUX4u5S/9RTb+nlQg1xepqTyZ5aq9kMnaJpFcqAsy0K28A2xm+TxhqEHmsKlzmhtvM4Sfg91lThfRxz4xUFqZ1GrW1RnaGKd36cqpajvGQQVKdzBSAoGjpLrFa1IML0LztlQe6XzlurdyiZANLT2luAWzCUxUPZA=="
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36:08-06:00" level=debug msg="completed challenge"
Feb 24 22:36:08 volumio go-librespot[28706]: time="2026-02-24T22:36: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 24 22:36:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:09 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:09 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:11 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 24 22:36:11 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 22:36:11 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 24 22:36:11 volumio volumio-remote-updater[26837]: Test mode disabled
Feb 24 22:36:11 volumio volumio-remote-updater[26837]: Alpha mode disabled
Feb 24 22:36:11 volumio volumio-remote-updater[26837]: Alpha legacy test mode disabled
Feb 24 22:36:11 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 24 22:36:11 volumio volumio[28169]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Fix for CPU utilization spike
\n- Fix for triggerhappy input permission
\n
\nNEW ADDITIONS
\n\n- Add BLE onboarding plugin
\n- Enable vc4-kms-v3d for all compatible RPi models
\n- Update Tidal SDK
\n
\n","title":"Update v4.096","updateavailable":true}
Feb 24 22:36:11 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 24 22:36:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68.
Feb 24 22:36:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:12 volumio go-librespot[28720]: go-librespot daemon starting...
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="app state loaded"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-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 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-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 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=info msg="zeroconf server listening on port 33981"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="obtained new client token: AAA5MRBnMHQlwCYqT8TD4Q+gMdLnijUs+vEGPFdIQLMutYT7IvcmYf5Gz9BX2+Hs7POdYgbbY+CgiIb2p4tIp+NglxSBIu5qG0b4Najo7RIK8HKpnapLht8xOCWjhlIz2dDrqt+AWpfUT6EvLPRVXgUP1ZJMCZNokCJ4WVB99UIf1Rj1W34jx+1z0S1h/RkIqWH7/UxqpzXN9f3LnbISnc8XgVTVdsl/DsWW4e4hWordyzS6kcYyAD58SQ=="
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36:12-06:00" level=debug msg="completed challenge"
Feb 24 22:36:12 volumio go-librespot[28721]: time="2026-02-24T22:36: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 24 22:36:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:12 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:12 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:14 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 24 22:36:14 volumio volumio[28169]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Feb 24 22:36:14 volumio volumio[28169]: info: CoreCommandRouter::volumioGetState
Feb 24 22:36:14 volumio volumio[28169]: info: CorePlayQueue::getTrack 0
Feb 24 22:36:15 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:15 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69.
Feb 24 22:36:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:15 volumio go-librespot[28728]: go-librespot daemon starting...
Feb 24 22:36:15 volumio go-librespot[28729]: time="2026-02-24T22:36:15-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:15 volumio go-librespot[28729]: time="2026-02-24T22:36:15-06:00" level=debug msg="app state loaded"
Feb 24 22:36:15 volumio go-librespot[28729]: time="2026-02-24T22:36:15-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:15 volumio go-librespot[28729]: time="2026-02-24T22:36:15-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-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 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-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 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-06:00" level=info msg="zeroconf server listening on port 41491"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-06:00" level=debug msg="obtained new client token: AABOuE6WeoYCNhqrz9DTahB3lOcDyJIUubZljNWDgu/ACbFv88BJLvQx5R9D8aWEPfyJp/z8gt4v90tao1k6ZbeUcM93CJBYZnqldWCbZ7lM3r+LPxhbeM5WFAEbSTZYnJ4tvpKkNxixT2G3o6+2aWxHESWJCNP2Dw53T3umlxfZEz8Yf78m5un4UBFpal7pTUDWfUpoBN7852SuzBTMEtWzJsSINg039pWC46YK6Tww+l7qwkx1LfU="
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36:16-06:00" level=debug msg="completed challenge"
Feb 24 22:36:16 volumio go-librespot[28729]: time="2026-02-24T22:36: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 24 22:36:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:18 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:18 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 24 22:36:19 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 24 22:36:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70.
Feb 24 22:36:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:19 volumio go-librespot[28750]: go-librespot daemon starting...
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-06:00" level=debug msg="app state loaded"
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36: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-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-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 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-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 24 22:36:19 volumio go-librespot[28751]: time="2026-02-24T22:36:19-06:00" level=info msg="zeroconf server listening on port 43635"
Feb 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36:20-06:00" level=debug msg="obtained new client token: AAAptPxnqWclJaYso9kuuq0T2E+xgDt6c1QMBF0Oz9Y/kZwtvJ++Rv9WdG4hB6VTCh60ga3F1wPJHl1Vak/4fkIte7ZpYRMEr8vpzKhiHbSfDrSt7EErsVxvj4LFZ8YOTm8GHY+lr7K3nbRm1OJlKSBTEWhqrVi255DE1ewSk+lzEe3tgSPcftvLDwjOAQoaqVqLjHfIvoR8WWvRJJmer8cX8qbOAZXN4zAk8YlRBKmQAaOoTG46Jfg="
Feb 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36:20-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 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36:20-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36:20-06:00" level=debug msg="completed challenge"
Feb 24 22:36:20 volumio go-librespot[28751]: time="2026-02-24T22:36: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 24 22:36:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:20 volumio volumio[28169]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 24 22:36:20 volumio volumio[28169]: info: Completed starting MyVolumio Plugin
Feb 24 22:36:20 volumio volumio[28169]: [Metrics] CommandRouter: 55s 576.67ms
Feb 24 22:36:20 volumio volumio[28169]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 24 22:36:20 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 22:36:20 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 22:36:20 volumio volumio[28169]: info: CoreCommandRouter::Close All Modals sent
Feb 24 22:36:20 volumio volumio[28169]: info: CoreCommandRouter::Close All Modals sent
Feb 24 22:36:21 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 24 22:36:21 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 22:36:21 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 24 22:36:21 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:21 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71.
Feb 24 22:36:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:23 volumio go-librespot[28764]: go-librespot daemon starting...
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="app state loaded"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-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 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-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 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=info msg="zeroconf server listening on port 46873"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="obtained new client token: AACIijmzU4AeuF1Hm6oK+BPk/9/fptEQsch32jTynE4Q88RWhlutWfQqXkTPBnO/7IImjekced+OfmtJX8vKC62mOqb/jOFu/upldtN/qwIt1UiBj+gYFu0scWbfJ/KwkUM7oHtSBbRwYmdvjeolzj9kv6U0kB8zfrcGK05lt3DrKEcOAcM8+840IDskVcRASKKdVqgf1DNSlLhvj9FsqdH/Gq0A22lxQxFppf+2G5jKM9cTYAw244ZfOg=="
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36:23-06:00" level=debug msg="completed challenge"
Feb 24 22:36:23 volumio go-librespot[28765]: time="2026-02-24T22:36: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 24 22:36:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:24 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:24 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72.
Feb 24 22:36:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:27 volumio go-librespot[28787]: go-librespot daemon starting...
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="app state loaded"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:27 volumio volumio[28169]: info: BOOT COMPLETED
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36: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 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36: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 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36: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 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=info msg="zeroconf server listening on port 42997"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="obtained new client token: AAB/3OEMA33vzPs0de55TUok7wVK/L+tGo7w3aTxbgDv/2tTF0rT8FBZq8FoXV5txd5VkmSN++zQ+jhhpn8vbebBz89p/5MyiE1jbK5wl64pT06R8TrZf+7Yjxfp++Wz/lMDDaMZmieSMrHMzujwrNgvcfKxWe4Mf7kQvG3j7vIyyLf+dYjsw+4Bc2cYZmHuMNm6JJdY6BZXJMVYKlWagDP039rfz+das8CcC2X8JxuYokhZ93Zqj+ctjw=="
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36:27-06:00" level=debug msg="completed challenge"
Feb 24 22:36:27 volumio go-librespot[28789]: time="2026-02-24T22:36: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 24 22:36:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:27 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:27 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:30 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:30 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73.
Feb 24 22:36:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:30 volumio go-librespot[28799]: go-librespot daemon starting...
Feb 24 22:36:30 volumio go-librespot[28800]: time="2026-02-24T22:36:30-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:30 volumio go-librespot[28800]: time="2026-02-24T22:36:30-06:00" level=debug msg="app state loaded"
Feb 24 22:36:30 volumio go-librespot[28800]: time="2026-02-24T22:36:30-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:30 volumio go-librespot[28800]: time="2026-02-24T22:36:30-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36: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 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36: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 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36: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 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36:31-06:00" level=info msg="zeroconf server listening on port 45353"
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36:31-06:00" level=debug msg="obtained new client token: AADKtxNm8SXBGSjaHHmsgCHIHd6/hA/z2pAkSUohpoGZfj06h/jJyQWTw3al5Iw7kdvo1JqwjwsT5igbRPK4zZd4m6fD9dtM5pSm9CsHRGHzsJtOnSZNN4VG97gAEav96Bkz+p0qI9V5pUGii8xopKK+9mSerxa84uwc9CzXpk/wXCCY5OxhqjYmQ0UTz2DIF7CCyrgrQgJtv2fyAyshSwGNZq6mcG2riv7WHuR6wFb6SIEdNAWxy0wpDQ=="
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36:31-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36:31-06:00" level=debug msg="completed challenge"
Feb 24 22:36:31 volumio go-librespot[28800]: time="2026-02-24T22:36: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 24 22:36:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:33 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:33 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74.
Feb 24 22:36:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:34 volumio go-librespot[28807]: go-librespot daemon starting...
Feb 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36:34-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36:34-06:00" level=debug msg="app state loaded"
Feb 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36:34-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36:34-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36: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 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36: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 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36: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 24 22:36:34 volumio go-librespot[28808]: time="2026-02-24T22:36:34-06:00" level=info msg="zeroconf server listening on port 39157"
Feb 24 22:36:35 volumio go-librespot[28808]: time="2026-02-24T22:36:35-06:00" level=debug msg="obtained new client token: AACD5p7YAxEx5wCunsl0NIdCVaNenw39PNP34IPmkwOot9H87fvj8oVEcCF2qwFHdurTEQUF3QnXlxaefRm+Q+XCQ/M5U11IdyeQyIBUqxDIX0ThPweutna8JsO17zqyYP+7PS5kJij4Io7tXPzZUsRCyyWkIGnqNQEcMKKsPbStSPbxwM9ndCxmAyrCfrUHBXOSQZFafM0fAoFBRNny/PtkcAG/eBi0JZEbBP8FNbxRPtHRVwMgrE0="
Feb 24 22:36:35 volumio go-librespot[28808]: time="2026-02-24T22:36:35-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:35 volumio go-librespot[28808]: time="2026-02-24T22:36:35-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:35 volumio go-librespot[28808]: time="2026-02-24T22:36:35-06:00" level=debug msg="completed challenge"
Feb 24 22:36:35 volumio go-librespot[28808]: time="2026-02-24T22:36: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 24 22:36:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:36 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:36 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75.
Feb 24 22:36:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:38 volumio go-librespot[28830]: go-librespot daemon starting...
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="app state loaded"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36: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-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-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 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-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 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=info msg="zeroconf server listening on port 37595"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="obtained new client token: AADCkxusNxS+8a5mXQZkiKKmKOjIbsYIQ6WV3RnjF8YhODorXPa/NqmENM3K5VIS1XOck8Fj9gm7ul8/cRk0sYcP9jPAyApBP+3BQ1vQZc09+A13YLn70ZQRXQM3G4xSVAZTMWZ3nvJSBYXewQ3WtcKJSaDA0rhuLDUZz39VmypTqPYSrZogQrPHwYSs4LSAQ43m9WLEt7qXah32Cvqa5tY9hx1YC8f1IG/QLceV7fJmnk1s/dJL2bwMOw=="
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36:38-06:00" level=debug msg="completed challenge"
Feb 24 22:36:38 volumio go-librespot[28831]: time="2026-02-24T22:36: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 24 22:36:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:39 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:39 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:41 volumio volumio[28169]: info: UPDATER: Scheduling automatic update
Feb 24 22:36:41 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Feb 24 22:36:41 volumio volumio[28169]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Feb 24 22:36:41 volumio volumio[28169]: info: UPDATER: Auto update will take place at: Wed Feb 25 2026 05:25:56 GMT-0600 (Central Standard Time)
Feb 24 22:36:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76.
Feb 24 22:36:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:42 volumio go-librespot[28838]: go-librespot daemon starting...
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="app state loaded"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-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 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-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 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=info msg="zeroconf server listening on port 33549"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="obtained new client token: AABze9yIN1/pKFN7LH7mdbVCzpw4c6qMjrGpTBdDegN1Rr5tJM1JXNpZUyXWA7hRUut2M5yJzzcsm0dqMDdRDs3WPGRr321SVN3KJqh1IeWZiErn/sD2vLwhL9WmnXAHH8xFt/GGjE01lZ1FiLGLAb+0MpN+ge/77AfrMlk1OsGGQjGihu/IiEuMOytQj0V6OzK2lWS0AyzOxLYpX1OztvJxz8V5oU73A+EmyPPnBnP1Q2xV+PyrnZKzyw=="
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36:42-06:00" level=debug msg="completed challenge"
Feb 24 22:36:42 volumio go-librespot[28839]: time="2026-02-24T22:36: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 24 22:36:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:42 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:42 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77.
Feb 24 22:36:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:45 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:45 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:45 volumio go-librespot[28846]: go-librespot daemon starting...
Feb 24 22:36:45 volumio go-librespot[28847]: time="2026-02-24T22:36:45-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:45 volumio go-librespot[28847]: time="2026-02-24T22:36:45-06:00" level=debug msg="app state loaded"
Feb 24 22:36:45 volumio go-librespot[28847]: time="2026-02-24T22:36:45-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:45 volumio go-librespot[28847]: time="2026-02-24T22:36:45-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36: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 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36: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 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36: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 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36:46-06:00" level=info msg="zeroconf server listening on port 45643"
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36:46-06:00" level=debug msg="obtained new client token: AAAT+2jK1YsWxodSFjSWbPS1qBL7c4TOcvCQ0cdtBWm0FPKAPYBz6RjrJu2Ixw4tAliFgygKhh2DzbVO9yBiOnbj8fQlEApHRgnjM4Yl7AkdQTwdHiM59XT6pYCst8/+0cDE6G+MLcetSZpUc9q0fZyExYIC5Z/Daoqal5PkmuMwN+mfoogKvw59BhsMz2SpptjTXU/1SJgFKPOjtgGPhd2DQoOUrdEo8kBVit3u8HNomZDOPWdX2SdvCw=="
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36:46-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36:46-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36:46-06:00" level=debug msg="completed challenge"
Feb 24 22:36:46 volumio go-librespot[28847]: time="2026-02-24T22:36: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 24 22:36:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:48 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:48 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78.
Feb 24 22:36:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:49 volumio go-librespot[28869]: go-librespot daemon starting...
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-06:00" level=debug msg="app state loaded"
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-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 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-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 24 22:36:49 volumio go-librespot[28870]: time="2026-02-24T22:36:49-06:00" level=info msg="zeroconf server listening on port 34529"
Feb 24 22:36:50 volumio go-librespot[28870]: time="2026-02-24T22:36:50-06:00" level=debug msg="obtained new client token: AAACb6PbxcOeqYNLIk+wk9Zdmy5fTG7HVuELLXMwawtC6NVqssoHT3PxYpQyH3MfUmHqO3hKvZ80WJxw13FPH0W4YMZpZbbcYwPRw2ecTEIbKxPMESFXMmYYjQ3w5w++3VZ9+YXxbskRf8LMvamt6/fCAR5n/ZdgAjjKDiobLPUL7d/hl9zF6l+aNNvEpT4jgJ0y7cPYkbEptmHjVhq5yDADc0nLiZ+sialfshSQWeOSSbYfnr9OUcs="
Feb 24 22:36:50 volumio go-librespot[28870]: time="2026-02-24T22:36:50-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:50 volumio go-librespot[28870]: time="2026-02-24T22:36:50-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:50 volumio go-librespot[28870]: time="2026-02-24T22:36:50-06:00" level=debug msg="completed challenge"
Feb 24 22:36:50 volumio go-librespot[28870]: time="2026-02-24T22:36: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 24 22:36:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:51 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:51 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79.
Feb 24 22:36:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:53 volumio go-librespot[28880]: go-librespot daemon starting...
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="app state loaded"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36: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 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36: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 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36: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 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=info msg="zeroconf server listening on port 44307"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="obtained new client token: AADrV2m0oJMLYcPPoaB3c0ekzUfXcSpJSJvMc8CKwlQ6mtm1PrbvQz5S1gq70twzz38DYu9/CL64G6SY4RX2lCeZHoH8TQRhoOa/UKUAAfL9CA50gze0KSpLQKwireUccVFbpads1HqSmJxuFzeyTCy2bTsfMUTDhbXhBmFvt5eWxQENOpTwt49RtGqoHj2LPBiwigVs75d56ZotRXk2DqWi/KaaHtvaPahX2qaTq4hu7GVw4ytg/scIDQ=="
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36:53-06:00" level=debug msg="completed challenge"
Feb 24 22:36:53 volumio go-librespot[28881]: time="2026-02-24T22:36: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 24 22:36:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:54 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:54 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:36:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80.
Feb 24 22:36:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:36:57 volumio go-librespot[28903]: go-librespot daemon starting...
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="app state loaded"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="stored credentials not found"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36: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 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36: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 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36: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 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=info msg="zeroconf server listening on port 33217"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="obtained new client token: AACv41DKDdgiVzC4V+/la3KASQs1MfGKtUXEbM4hOqztln1+6AqwT4GzP/covEcIZDplkGvh1ZYUKhFEbgE/LfnUgmCkGU9SjvAFfNvx3DBhxAfLyi0m7Tf7/Q3aIgRda2y8JqsD9CZacx4Bb5oKiPiWDeaChDnRpzFLy5kvmN3qJLJupHk7MIbT7CEZ4ECjJ1qt4MfZlfzC/QGLCuSnT5eauvPdJRYNbItqi1T/3qcvn32e9Sa2K2zmhA=="
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="completed keyexchange"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36:57-06:00" level=debug msg="completed challenge"
Feb 24 22:36:57 volumio go-librespot[28904]: time="2026-02-24T22:36: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 24 22:36:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:36:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:36:57 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:36:57 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81.
Feb 24 22:37:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:00 volumio go-librespot[28913]: go-librespot daemon starting...
Feb 24 22:37:00 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:00 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:00 volumio go-librespot[28914]: time="2026-02-24T22:37:00-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:00 volumio go-librespot[28914]: time="2026-02-24T22:37:00-06:00" level=debug msg="app state loaded"
Feb 24 22:37:00 volumio go-librespot[28914]: time="2026-02-24T22:37:00-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:00 volumio go-librespot[28914]: time="2026-02-24T22:37:00-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-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 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-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 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-06:00" level=info msg="zeroconf server listening on port 41633"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-06:00" level=debug msg="obtained new client token: AAADveSQguS/vHxMfeslTv7CAnlvVdvLVE1GfHDOWCjJvUrTPCpNZVqSOzaEbHuZRqxx3R/rf1jiO/xEpXtkzH0WJzrpv9yEMvjy3OIw0jBTBasBv0VMnWk6BvFdJUan0n0sp54rm+DTM0fi21MWZd0vZ8ZjkJFGtTuOe22vau4nLoIuEBtCT43WPHbXV7CY3hvHid0Yt/6rM+KBT+osV1AsW/a0TKXKCKNjHThAXQkT0REMe574y6E="
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37:01-06:00" level=debug msg="completed challenge"
Feb 24 22:37:01 volumio go-librespot[28914]: time="2026-02-24T22:37: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 24 22:37:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:03 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:03 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82.
Feb 24 22:37:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:04 volumio go-librespot[28921]: go-librespot daemon starting...
Feb 24 22:37:04 volumio go-librespot[28922]: time="2026-02-24T22:37:04-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:04 volumio go-librespot[28922]: time="2026-02-24T22:37:04-06:00" level=debug msg="app state loaded"
Feb 24 22:37:04 volumio go-librespot[28922]: time="2026-02-24T22:37:04-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:04 volumio go-librespot[28922]: time="2026-02-24T22:37:04-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-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 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-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 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-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 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-06:00" level=info msg="zeroconf server listening on port 42061"
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-06:00" level=debug msg="obtained new client token: AABBZ2whUbK692xR6RW7G6D4J/jMHvlJjSIKzo+4h10bHi79psqeo99ZFSaAyj6lBdO92WisNZ6sWBD6zUHRbhnRDnzfJmlt08rMbg4Ap5jB+gu7Ntd9whSVbTHIHg7/WINqohu4aUjlwtRkWoFDxKJHa3w0BqlAetkvczIKasyW843aZuTCucwp7a0qteUEFs+3FwMnurXntcSv1mBHRkpF/Th/ewAv2Wka0UD3NXarMvn0DftHiac="
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37:05-06:00" level=debug msg="completed challenge"
Feb 24 22:37:05 volumio go-librespot[28922]: time="2026-02-24T22:37: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 24 22:37:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:06 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:06 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83.
Feb 24 22:37:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:08 volumio go-librespot[28944]: go-librespot daemon starting...
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="app state loaded"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-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 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-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 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=info msg="zeroconf server listening on port 45447"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="obtained new client token: AADojuXMdzLzT3gc48FJoO2LXurSA5F2bGd0iLc4PxAhL7aFi7gp8thJDCWf41zqIYsuBAULvLuPg40MjAjlu+Q9PF8d5IqxJT6et0BQ3oPgu7ywG6p0nplMIK5dOfkMkXAJ5osLTtpzDxLinG1Ijd3nnAj6pzQo3zqVdDMZsyqbiCOCOIAvgjpdBmVoND8PPUWGCXUjXePZ33PceDIv+JBE+J1Eo9K6M0Gc0xYfzYQsW/Igwe7hnXBuFw=="
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37:08-06:00" level=debug msg="completed challenge"
Feb 24 22:37:08 volumio go-librespot[28945]: time="2026-02-24T22:37: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 24 22:37:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:09 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:09 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84.
Feb 24 22:37:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:12 volumio go-librespot[28955]: go-librespot daemon starting...
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="app state loaded"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37: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 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37: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 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37: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 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=info msg="zeroconf server listening on port 33019"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="obtained new client token: AABcnI652675f6Zp+vNTUbumuzh4CdkrOVc3iNnIr+67++jFy4ARb+Z88fnDkZhEx5KR7dhOBUBM7u+5a2nPrXubVoBHZS0NJjyBzf+XD/DRHPvAr52NPQd1crH0WICmtm2roMsX2MxRRYqweJL84q0JPQbpR2i4pop+ppKvsflMe6m+5BaWnPruEOiIv4ZL8kgCYrlpx/BpH0kEkhddfmt8L0zrsT1EKjJFW3TRXfDp/YDJLRXU7Bs7YQ=="
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37:12-06:00" level=debug msg="completed challenge"
Feb 24 22:37:12 volumio go-librespot[28956]: time="2026-02-24T22:37: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 24 22:37:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:12 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:12 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85.
Feb 24 22:37:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:15 volumio go-librespot[28963]: go-librespot daemon starting...
Feb 24 22:37:15 volumio go-librespot[28964]: time="2026-02-24T22:37:15-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:15 volumio go-librespot[28964]: time="2026-02-24T22:37:15-06:00" level=debug msg="app state loaded"
Feb 24 22:37:15 volumio go-librespot[28964]: time="2026-02-24T22:37:15-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:15 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:15 volumio go-librespot[28964]: time="2026-02-24T22:37:15-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:15 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-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 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-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 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-06:00" level=info msg="zeroconf server listening on port 40525"
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-06:00" level=debug msg="obtained new client token: AABk7+5z3EDVcmQIuTkhT+gbdB56Ch9lwl/gutLcuT6k0mZsjhjMyH4q2J+GCXhkjZ7gCjkPhAyYcefaPHzIXTzWTbvbnlYqDxMVbCA6gv7YsnqJTq9DcmbPrpsufM540DTjTJYS2FQaTnKp7pnd6Q4qV5UOOTgXe4OJu/vWuXGpt1f0+95cEALLjZrNwxQtoJAraM9yY3dlr6UHmagTCFyXsIzUlOgBmjhBWgzE2L2VbDWED0NwYyz8mg=="
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-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 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37:16-06:00" level=debug msg="completed challenge"
Feb 24 22:37:16 volumio go-librespot[28964]: time="2026-02-24T22:37: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 24 22:37:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:18 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:18 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86.
Feb 24 22:37:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:19 volumio go-librespot[28985]: go-librespot daemon starting...
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-06:00" level=debug msg="app state loaded"
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37: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-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-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 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-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 24 22:37:19 volumio go-librespot[28986]: time="2026-02-24T22:37:19-06:00" level=info msg="zeroconf server listening on port 33551"
Feb 24 22:37:20 volumio go-librespot[28986]: time="2026-02-24T22:37:20-06:00" level=debug msg="obtained new client token: AACZ9+YH2TADWUClMn1WzQNc2DpscASgmc/P+xTyafiurEQgMDRC02JtBFdwa+/GH3Mzqv8QnkbHahyh5jSomhwxcdo7jY+SeCgMd6SAmm3jJOXvgf7nbndeBN0C28cndmHUH8UuRIelwcRcsgTZqNQtnl2yHDRULmyOtmLp1gUTrCFZqUjHTY+GFj20U69h+Bfco8grsFlo4iRgx4/gmt53ex2mq0cFhBep1aAYi9VjV5cDXhwXQ6c="
Feb 24 22:37:20 volumio go-librespot[28986]: time="2026-02-24T22:37:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:20 volumio go-librespot[28986]: time="2026-02-24T22:37:20-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:20 volumio go-librespot[28986]: time="2026-02-24T22:37:20-06:00" level=debug msg="completed challenge"
Feb 24 22:37:20 volumio go-librespot[28986]: time="2026-02-24T22:37: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 24 22:37:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:21 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:21 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87.
Feb 24 22:37:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:23 volumio go-librespot[28993]: go-librespot daemon starting...
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="app state loaded"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37: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-gew4.spotify.com:80]"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-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 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-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 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=info msg="zeroconf server listening on port 35179"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="obtained new client token: AABuBDLsidrDNhbmOyKEgcyrZN6WSE+dDaUvZvL+DcS3Qnn6hENdHTTndh80OTs/yGa2tdirZSN4Ggt6ySKXCm9cI9gU9GFjwdgJorLf+E2CanUlPGNaJ9tLQuGp8PUp7MOrvNNpjRpPvuvvk2JslJAF2iWsy0oVBJavnBdb23rq6jNqfg5HkbCLfVIk1Q6j3InPbFkkmcTjC+XiRp8U9svBHiZNu39mDqxvg3jjawut7XZ1M09gcc5mHA=="
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37:23-06:00" level=debug msg="completed challenge"
Feb 24 22:37:23 volumio go-librespot[28994]: time="2026-02-24T22:37: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 24 22:37:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:24 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:24 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88.
Feb 24 22:37:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:27 volumio go-librespot[29001]: go-librespot daemon starting...
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="app state loaded"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37: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-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-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 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-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 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=info msg="zeroconf server listening on port 43623"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="obtained new client token: AAAKF8hT/TD9tNsy3M/U9yA7n8Xu5FQEiTlysjJ8l6ZLboAtxe1dQqqJcPqr6iXYVkcDDO68oKjxRWwJbxAjG0b6bAYsmH9ol4n2NW2PwzAtgTFddHR/gGSya1Xeoh16ejtXFms4utB6nqIyFvqNpWBRfkd82GUB+8/ReoVBERVARdmUcNNGjYhBuRYdYHRqA6R+tlOZpKvBT39ETeuIRQPD6Ld3D39bVEDSngG/j+jveubS9nTnf2Mqdw=="
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37:27-06:00" level=debug msg="completed challenge"
Feb 24 22:37:27 volumio go-librespot[29016]: time="2026-02-24T22:37: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 24 22:37:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:27 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:27 volumio volumio[28169]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89.
Feb 24 22:37:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:30 volumio go-librespot[29028]: go-librespot daemon starting...
Feb 24 22:37:30 volumio go-librespot[29029]: time="2026-02-24T22:37:30-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:30 volumio go-librespot[29029]: time="2026-02-24T22:37:30-06:00" level=debug msg="app state loaded"
Feb 24 22:37:30 volumio go-librespot[29029]: time="2026-02-24T22:37:30-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:30 volumio go-librespot[29029]: time="2026-02-24T22:37:30-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:30 volumio volumio[28169]: info: Initializing connection to go-librespot Websocket
Feb 24 22:37:30 volumio go-librespot[29029]: time="2026-02-24T22:37:30-06:00" level=debug msg="new websocket client"
Feb 24 22:37:31 volumio volumio[28169]: info: Connection to go-librespot Websocket established
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-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 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-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 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-06:00" level=info msg="zeroconf server listening on port 34527"
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-06:00" level=debug msg="obtained new client token: AADm+bY8CsOnXZ2GV2Hy2VAG1dc5UKMMhWb0Zk0jn+ufvlwvDLOom5tyLSZ0LLD4hgGZGyN+PunWbKFB+nyM8u1T1ZIyXaXChJbOjmPBhPh9wtbU/bEWEkANPYm3LrT4YN9B8WXAk9er+/Y23LMW/BKOkzjWXqnnVu58SXH7JRUI5FGw8Y2lEutUv5apUNLCFaCFdhA5yWIUknApfbG4GrDav8x+btOH7+/z+NQ3YaXS4/b/YQheIYjRDQ=="
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-06:00" level=debug msg="completed keyexchange"
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37:31-06:00" level=debug msg="completed challenge"
Feb 24 22:37:31 volumio go-librespot[29029]: time="2026-02-24T22:37: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 24 22:37:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 22:37:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 22:37:31 volumio volumio[28169]: info: Connection to go-librespot Websocket closed
Feb 24 22:37:34 volumio volumio[28169]: info: Getting Spotify volume
Feb 24 22:37:34 volumio volumio[28169]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 22:37:34 volumio volumio[28169]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 22:37:34 volumio volumio[28169]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 24 22:37:34 volumio volumio[28169]: errno: -111,
Feb 24 22:37:34 volumio volumio[28169]: code: 'ECONNREFUSED',
Feb 24 22:37:34 volumio volumio[28169]: syscall: 'connect',
Feb 24 22:37:34 volumio volumio[28169]: address: '127.0.0.1',
Feb 24 22:37:34 volumio volumio[28169]: port: 9879,
Feb 24 22:37:34 volumio volumio[28169]: response: undefined
Feb 24 22:37:34 volumio volumio[28169]: }
Feb 24 22:37:34 volumio volumio[28169]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 22:37:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90.
Feb 24 22:37:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 22:37:34 volumio go-librespot[29048]: go-librespot daemon starting...
Feb 24 22:37:34 volumio go-librespot[29049]: time="2026-02-24T22:37:34-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 22:37:34 volumio go-librespot[29049]: time="2026-02-24T22:37:34-06:00" level=debug msg="app state loaded"
Feb 24 22:37:34 volumio go-librespot[29049]: time="2026-02-24T22:37:34-06:00" level=debug msg="stored credentials not found"
Feb 24 22:37:34 volumio go-librespot[29049]: time="2026-02-24T22:37:34-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 22:37:34 volumio sudo[29058]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 22:36'
Feb 24 22:37:34 volumio sudo[29058]: 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"