Feb 24 06:16:01 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:01 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16.
Feb 24 06:16:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:01 volumio go-librespot[27453]: go-librespot daemon starting...
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="app state loaded"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16: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 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16: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 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16: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 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=info msg="zeroconf server listening on port 35681"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="obtained new client token: AAAc8d78V1IxLNqcIyxUvMAYKO/Y/Ziz8fCs0FJ9vHZMbvEq3HQ7KVYoUHnTFNxpDmK57tChvIAF/mJF2IrdJu7uIVGAJ7oxUPJwXmQ/4KO0VGDDRkWCPbYGaxEA3DWjspU/D+R5phE1DMj2FYAGafxQR+VpiHfQMKYRtomNJan+hedkDotr/N+IjTuOM+zAydi7fo8fIhfvj4nkpXrL/6RReVLCiSfXcpS77yfBdLfS56E/dDcYxOXpBA=="
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16:01-06:00" level=debug msg="completed challenge"
Feb 24 06:16:01 volumio go-librespot[27454]: time="2026-02-24T06:16: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 06:16:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:04 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:04 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:04 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 24 06:16:04 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 06:16:04 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 24 06:16:04 volumio volumio-remote-updater[26837]: Test mode disabled
Feb 24 06:16:04 volumio volumio-remote-updater[26837]: Alpha mode disabled
Feb 24 06:16:04 volumio volumio-remote-updater[26837]: Alpha legacy test mode disabled
Feb 24 06:16:04 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 24 06:16:04 volumio volumio[26915]: 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 06:16:04 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 24 06:16:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17.
Feb 24 06:16:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:05 volumio go-librespot[27469]: go-librespot daemon starting...
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=debug msg="app state loaded"
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16: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 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16: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 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16: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 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=info msg="zeroconf server listening on port 34023"
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=debug msg="obtained new client token: AACQllpTn1Kv3owYZ11J3ZkNvRXIGKLY4Zbbu9xduB2wvfJS4zhqV3/rUuK8BBYAehVXLx3+5Kz32Quzf/mrablSYwBGd/PlYBUeVxvQxl6HUWivPM3DpgobpeJeuwYkrkxfTizgxhDC8+D5mmoFH97xhF8j5r4XT4N4n3hpL/+MwAS4qb4QziVfzzehmOS4Ry5D1vudYAMwVZnro37VhYOAsS1bCTCpQ9c1Lo7sYXwM+vm4Xy1FK5dtGA=="
Feb 24 06:16:05 volumio go-librespot[27470]: time="2026-02-24T06:16:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:06 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 24 06:16:06 volumio volumio[26915]: 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 06:16:06 volumio volumio[26915]: info: CoreCommandRouter::volumioGetState
Feb 24 06:16:06 volumio volumio[26915]: info: CorePlayQueue::getTrack 0
Feb 24 06:16:06 volumio go-librespot[27470]: time="2026-02-24T06:16:06-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:06 volumio go-librespot[27470]: time="2026-02-24T06:16:06-06:00" level=debug msg="completed challenge"
Feb 24 06:16:06 volumio go-librespot[27470]: time="2026-02-24T06:16:06-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 06:16:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:07 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:07 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18.
Feb 24 06:16:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:09 volumio go-librespot[27477]: go-librespot daemon starting...
Feb 24 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-06:00" level=debug msg="app state loaded"
Feb 24 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-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 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-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 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-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 06:16:09 volumio go-librespot[27478]: time="2026-02-24T06:16:09-06:00" level=info msg="zeroconf server listening on port 36057"
Feb 24 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-06:00" level=debug msg="obtained new client token: AABKTK41hEWMy/LJigFXN//i7/hUsCIXdeHP3sHeA+HeebL/fvqGPXEeIeQ+HOsX/kxp+Vk596NkgNw7YC7k9WjTDifS1v1iTLB5H+tpjZJcxvwp4LL4mHEhYtXGe3kPKukvzLs0HWUho732Q3ZzhGFCOry3FHbGWLfA3FEhCz14E2rJ6Ykq28avPxN8gj00DQEBBH1RAb33EeD29ekPXBAiVFtumNyYH2O//gyi9vidwPWy7FoPFhE="
Feb 24 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-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 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 24 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-06:00" level=debug msg="completed challenge"
Feb 24 06:16:10 volumio go-librespot[27478]: time="2026-02-24T06:16:10-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 06:16:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:10 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:10 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 24 06:16:11 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 24 06:16:12 volumio volumio[26915]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 24 06:16:12 volumio volumio[26915]: info: Completed starting MyVolumio Plugin
Feb 24 06:16:12 volumio volumio[26915]: [Metrics] CommandRouter: 54s 761.83ms
Feb 24 06:16:12 volumio volumio[26915]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 24 06:16:12 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 06:16:12 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 06:16:12 volumio volumio[26915]: info: CoreCommandRouter::Close All Modals sent
Feb 24 06:16:12 volumio volumio[26915]: info: CoreCommandRouter::Close All Modals sent
Feb 24 06:16:13 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 24 06:16:13 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 06:16:13 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 24 06:16:13 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:13 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19.
Feb 24 06:16:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:13 volumio go-librespot[27505]: go-librespot daemon starting...
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="app state loaded"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-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 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-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 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-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 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=info msg="zeroconf server listening on port 37875"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="obtained new client token: AACwst9GMhAUr4o8kCAdxdRBWHJz5UI2utKWGUEEORBVoLwbRhsArnUs7EWmSnDpuP4SHmxHJb0NP5p/vIfiBrL4bdjohqBh0amFIiulsWI+da5ZUjR8IBn966WjAg4CjakPA4KGkgo2bJv/LEUuiio4QcT7RBxGnyyOYQE68rsso6Hg2VGr6Fi6ZJLl+kJ3Ysbw4fzLrvwMbqpAXuiExX0t9MDnZ+H3y9BoPYPW8cZhwmofEtaO7exnlw=="
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-06:00" level=debug msg="completed challenge"
Feb 24 06:16:13 volumio go-librespot[27506]: time="2026-02-24T06:16:13-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 06:16:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:16 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:16 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20.
Feb 24 06:16:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:17 volumio go-librespot[27513]: go-librespot daemon starting...
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="app state loaded"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-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 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-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 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-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 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=info msg="zeroconf server listening on port 38801"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="obtained new client token: AAAQdZPQ7qRzsMyFM06eDVEh2iLsg/dKjQZzIhbOrLCzI2t2hJxQNsPwlmGIWm7e0ls2nk/x5OIcv+w3rZrX/DepIoA7t1dvxlttGqfU6mxdh6b/JiiqQQAizbXlIhK79W3SoiLr2DYWkYCKJHp9DTTvj9HMVQI8Q3f/i9XZg9O/41M/rqv+GEdF4UJ3+R93wz+8UXdzfFKmwAAuz7/HN/YgmGaCMH4EAxze3txU4QAhmsLDuy0is+ylZw=="
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-06:00" level=debug msg="completed challenge"
Feb 24 06:16:17 volumio go-librespot[27514]: time="2026-02-24T06:16:17-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 06:16:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:19 volumio volumio[26915]: info: BOOT COMPLETED
Feb 24 06:16:19 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:19 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21.
Feb 24 06:16:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:20 volumio go-librespot[27535]: go-librespot daemon starting...
Feb 24 06:16:20 volumio go-librespot[27536]: time="2026-02-24T06:16:20-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:20 volumio go-librespot[27536]: time="2026-02-24T06:16:20-06:00" level=debug msg="app state loaded"
Feb 24 06:16:20 volumio go-librespot[27536]: time="2026-02-24T06:16:20-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:20 volumio go-librespot[27536]: time="2026-02-24T06:16:20-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-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 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-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 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-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 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-06:00" level=info msg="zeroconf server listening on port 39651"
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-06:00" level=debug msg="obtained new client token: AAAX1etdfDoqydM3+ze8FZKjHjopV8OgyFN8pwVNfyAQY8vrXrTH5e7t/AGWtZ2y8xAl3bPWNfR/qBDHW7AFwB3LRUrPjiOoAPRNYPhvGjHwtUjKyDG1aWFd341duQKcCZRuTwVAdn5RIWEHl/CMx2yQ7D/Tb2yV3ie8a4w31dwWv0i5UB9A3nWx5DSfh43VBcenOw3LTYzqhWGdSpB6V29Vs1GgFxb63IeVt6tbrYET6eHh6POz99LX7Q=="
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-06:00" level=debug msg="completed challenge"
Feb 24 06:16:21 volumio go-librespot[27536]: time="2026-02-24T06:16:21-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 06:16:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:22 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:22 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22.
Feb 24 06:16:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:24 volumio go-librespot[27547]: go-librespot daemon starting...
Feb 24 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-06:00" level=debug msg="app state loaded"
Feb 24 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-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 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-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 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-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 06:16:24 volumio go-librespot[27548]: time="2026-02-24T06:16:24-06:00" level=info msg="zeroconf server listening on port 35905"
Feb 24 06:16:25 volumio go-librespot[27548]: time="2026-02-24T06:16:25-06:00" level=debug msg="obtained new client token: AACgUXHCO9XDHnHXuB0gEDoL7IIAsX80K32b4T34pcNv/YpROjte7O0UL4bslk/RY6FcXvq3dvQSj6nEh4MsCbOJpHEViQn/c158KpuB2Tbxprz8SuhBjRyR50xY/a4T0luVf6W9YkEKOgHTOUD24xOg7DobJkVvymb+oz6J4gZnSDi/a2+fc0jrwDDezBQz//PUdKtt1RO35xJPbPBWCGrjLLI7OfTIA/TNveNPwiVHeSYZQt2yfFA="
Feb 24 06:16:25 volumio go-librespot[27548]: time="2026-02-24T06:16:25-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:25 volumio go-librespot[27548]: time="2026-02-24T06:16:25-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:25 volumio go-librespot[27548]: time="2026-02-24T06:16:25-06:00" level=debug msg="completed challenge"
Feb 24 06:16:25 volumio go-librespot[27548]: time="2026-02-24T06:16:25-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 06:16:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:25 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:25 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:28 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:28 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23.
Feb 24 06:16:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:28 volumio go-librespot[27555]: go-librespot daemon starting...
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="app state loaded"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-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 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-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 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-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 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=info msg="zeroconf server listening on port 36859"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="obtained new client token: AABzzyaOFjRm8PcuOnfEo48BBz8VipjXidDzcEydpuVaw5GdginUeQrD1/X50ouOD2pqLeSjb042IBBrrREmG3GpnmgDTiKFb1+jQWVrhC5uwktPSsb1pPSIh8O+/1Y8sOX3OuejkVPb6uZXpZ4+DJms8kGl7b0auzw2ljHaJPGvQqKqXwQfDE3FeA40Rc1kE6PwV+Wj6m/UyCk2by3YhKmrFA+ztKtkSXUwswYwGzwCQ+oHyvg1LmIeIg=="
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-06:00" level=debug msg="completed challenge"
Feb 24 06:16:28 volumio go-librespot[27556]: time="2026-02-24T06:16:28-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 06:16:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:31 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:31 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Feb 24 06:16:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:32 volumio go-librespot[27577]: go-librespot daemon starting...
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="app state loaded"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-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 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-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 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-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 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=info msg="zeroconf server listening on port 37789"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="obtained new client token: AACiEA29xwGngZyfxN6MshPrdwXEfQhzdn8WhxM0ykOf1ij2uRE1iiqkWi7IkOgcosEJ4xqu7nqKtdaXny4ZgYKxRd2tymsutsHG+7p3TY3wyP4cchAMtA9jEyzowlzm3tgb96ygOjKiSd/AxdYrcOHguS8ZHfTrcAtzpN6ho814Z9Ug3iwiSFMP5MZh1lRqXo4zfHxJEFo6aYunctRPp1pN1QxXRVm2+g4fimHjfQ3xmScGVNRj6SJ3AA=="
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-06:00" level=debug msg="completed challenge"
Feb 24 06:16:32 volumio go-librespot[27578]: time="2026-02-24T06:16:32-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 06:16:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:34 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:34 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:34 volumio volumio[26915]: info: UPDATER: Scheduling automatic update
Feb 24 06:16:34 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Feb 24 06:16:34 volumio volumio[26915]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Feb 24 06:16:34 volumio volumio[26915]: info: UPDATER: Auto update will take place at: Wed Feb 25 2026 04:16:17 GMT-0600 (Central Standard Time)
Feb 24 06:16:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25.
Feb 24 06:16:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:35 volumio go-librespot[27585]: go-librespot daemon starting...
Feb 24 06:16:35 volumio go-librespot[27586]: time="2026-02-24T06:16:35-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:35 volumio go-librespot[27586]: time="2026-02-24T06:16:35-06:00" level=debug msg="app state loaded"
Feb 24 06:16:35 volumio go-librespot[27586]: time="2026-02-24T06:16:35-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:35 volumio go-librespot[27586]: time="2026-02-24T06:16:35-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-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 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-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 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-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 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-06:00" level=info msg="zeroconf server listening on port 36995"
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-06:00" level=debug msg="obtained new client token: AAAT8vRlXRmENkA61lnuhnZtjnSjPxEOSqFKNO7GJCVJLIT3c7LozlpK7ptV1TgOIfOVnnw7quHGgrvlx4HiQtQatSTpOoZFXwph1NwGn2vrGMoT1MC3RVCIph+1VVlF3CoZ7X8MHA4pSlLxukpDpk+sN+tzg0paklpaLu+FNO0Bl2AKWklogMpKveNZMCv6ZpmbLKFofaT28ArPvvIVzYIY26odlTDvkVI8RjZ1X4ccVZ3aMzdT8sg="
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-06:00" level=debug msg="completed challenge"
Feb 24 06:16:36 volumio go-librespot[27586]: time="2026-02-24T06:16:36-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 06:16:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:37 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:37 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Feb 24 06:16:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:39 volumio go-librespot[27593]: go-librespot daemon starting...
Feb 24 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-06:00" level=debug msg="app state loaded"
Feb 24 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-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 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-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 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-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 06:16:39 volumio go-librespot[27594]: time="2026-02-24T06:16:39-06:00" level=info msg="zeroconf server listening on port 40445"
Feb 24 06:16:40 volumio go-librespot[27594]: time="2026-02-24T06:16:40-06:00" level=debug msg="obtained new client token: AABdAUKLM8jbg1+6vSGcE7POd6Wv2J7pbjlK4d4w9aqYlxoBqyL66ShBB4Mbip8st1/53bAZf7UvEul5YU+DHSvLABmop4ADeLSj42WYFHXMsK/lXNoSbFQWFmfOfBez6ebFzFAtwQSsA2EzSaf1klSAg4mWTbxSON5nmgtgOOcZjpOYZNt8r/MkSxr1+Qt92SFUkn6bOMy08TacDLiHZGPlObSbS1JFCZ5+tUmHQn8/P4wkFZSYgVY="
Feb 24 06:16:40 volumio go-librespot[27594]: time="2026-02-24T06:16:40-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:40 volumio go-librespot[27594]: time="2026-02-24T06:16:40-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:40 volumio go-librespot[27594]: time="2026-02-24T06:16:40-06:00" level=debug msg="completed challenge"
Feb 24 06:16:40 volumio go-librespot[27594]: time="2026-02-24T06:16:40-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 06:16:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:40 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:40 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Feb 24 06:16:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:43 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:43 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:43 volumio go-librespot[27616]: go-librespot daemon starting...
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="app state loaded"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-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 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-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 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-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 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=info msg="zeroconf server listening on port 45947"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="obtained new client token: AAA/CYyLlNdNlFem3vPVS+4gYnEDcSUwEmlizpDPPMqWXVFoHG4ooHWz6l0EZySLxP9LU4a9jxjRBwfjWota2tP8NZrLBeZPI4pUsaWtT2gc5Z6RG8sl/UAnym9TVCaTsW50tmiUNA9QxmGxkGtrVZevJYlaNLfiCBLF9aIt26ZM4WuaUK+9e/CCHO8WoflIx/DURok18e2ES34H5LmUUKq4MYAgTXzN1yNdhs39B/C/DZyukCJkDr49tg=="
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-06:00" level=debug msg="completed challenge"
Feb 24 06:16:43 volumio go-librespot[27617]: time="2026-02-24T06:16:43-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 06:16:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:46 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:46 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Feb 24 06:16:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:47 volumio go-librespot[27627]: go-librespot daemon starting...
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="app state loaded"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-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 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-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 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-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 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=info msg="zeroconf server listening on port 46211"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="obtained new client token: AAD22hB1pAA1EzSfzcdS8cgXCAOTJC6nobWJmXMM92EujO3/AK2LptYTBnliZDaQf5hP5sYCar7FoBDPjHDTHMJolHX/TlW6bn5zegyois3FW3EShhkKsEHIjZZKaJlaPAE4i5A58stlH10VcXcPLB2o47sWGpAHln0V9nrm4RqY8rbw91qXj9SLqOu4aMJ+UciEqmSRgt1toWVzsRMLxYaNoLLMhrZdmK4JA5AxUZDg7qT3WflXnY73EA=="
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-06:00" level=debug msg="completed challenge"
Feb 24 06:16:47 volumio go-librespot[27628]: time="2026-02-24T06:16:47-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 06:16:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:49 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:49 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Feb 24 06:16:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:50 volumio go-librespot[27649]: go-librespot daemon starting...
Feb 24 06:16:50 volumio go-librespot[27650]: time="2026-02-24T06:16:50-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:50 volumio go-librespot[27650]: time="2026-02-24T06:16:50-06:00" level=debug msg="app state loaded"
Feb 24 06:16:50 volumio go-librespot[27650]: time="2026-02-24T06:16:50-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:50 volumio go-librespot[27650]: time="2026-02-24T06:16:50-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-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 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-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 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-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 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-06:00" level=info msg="zeroconf server listening on port 41515"
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-06:00" level=debug msg="obtained new client token: AADdjuc9f3bYOD3vzVkuotheU1mLzHmePCTX1paqwiP6S2o+pUbEvy6HK56cO1CBmw2PkuwBsWBaLq3Mjgm4nQrKxuvm++BK8/d/gykZ/A9OHza/WAXdFgbJ3S27/JIMXExvn+O0KV3AI+kM/cp8L1AGOxqfZa2ALM9pnnQjzvUPOeGsaDFUw1sHqfi5XhHXXQzoDCtCX2G6RYgCxemfTXsquwLBkYAsk2ihaPw7FAIwIcQUK1Cd6NKMKw=="
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-06:00" level=debug msg="completed challenge"
Feb 24 06:16:51 volumio go-librespot[27650]: time="2026-02-24T06:16:51-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 06:16:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:52 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:52 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Feb 24 06:16:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:54 volumio go-librespot[27657]: go-librespot daemon starting...
Feb 24 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-06:00" level=debug msg="app state loaded"
Feb 24 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-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 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-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 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-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 06:16:54 volumio go-librespot[27658]: time="2026-02-24T06:16:54-06:00" level=info msg="zeroconf server listening on port 46409"
Feb 24 06:16:55 volumio go-librespot[27658]: time="2026-02-24T06:16:55-06:00" level=debug msg="obtained new client token: AAAGJi52IJXRtPM2/yHnt2o+F+lhEocbOrZVeVNTg1oKan/toYvIaWkf0gK4F4FHPUU9TJjzCuX3kVC5L2wD7Htkh/RLsJkUXdqy0ZS+GWudFOQH7UOZCfl/wDpUFFbxYLy/3wY+nMPLWjsd0Bd/F0MHexpGwnFG8YN7Cg8+TYCLri8F8H/oQn428Rv9S3vPIhHHXpfWm53k7IhSaicyLxszaa5yeSMWLu/xJ/MfoYH28qiIQKjsSEg="
Feb 24 06:16:55 volumio go-librespot[27658]: time="2026-02-24T06:16:55-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:55 volumio go-librespot[27658]: time="2026-02-24T06:16:55-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:55 volumio go-librespot[27658]: time="2026-02-24T06:16:55-06:00" level=debug msg="completed challenge"
Feb 24 06:16:55 volumio go-librespot[27658]: time="2026-02-24T06:16:55-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 06:16:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:16:55 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:55 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Feb 24 06:16:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:16:58 volumio go-librespot[27666]: go-librespot daemon starting...
Feb 24 06:16:58 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:16:58 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="app state loaded"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="stored credentials not found"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-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 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-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 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-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 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=info msg="zeroconf server listening on port 34821"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="obtained new client token: AAAZVvSjoS8qDs+/vEeL+W0TNDpttDjK8IxE8O5nGWn73HgdOBhseyqF0i5MND2pEmob9rWpGaP14uW05aioEoXtqmJsu9AZTmkClYUhnpJhzMUDgCf6dNSFGSmwQlTlG+BPHEVysx5v9m0/Ca1NECSqjQO0mNAntL8DOSy2hwldOiySaiqw0Sr8e9SZA2eXL8QBx3ykreRh7jXhtcZJkzGgdA16EqnoxF3URF71+VgWHeBEaiOu13VNnw=="
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="completed keyexchange"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-06:00" level=debug msg="completed challenge"
Feb 24 06:16:58 volumio go-librespot[27667]: time="2026-02-24T06:16:58-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 06:16:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:16:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:01 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:01 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Feb 24 06:17:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:02 volumio go-librespot[27689]: go-librespot daemon starting...
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="app state loaded"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-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 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-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 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-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 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=info msg="zeroconf server listening on port 45043"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="obtained new client token: AAAjGlcR3+BH3gx7kNRY7NUMfEDWNz+vMsZr6K3RWBYQHNEZlGtxt9jcAIu8TJv9TMMYthkk+Nvpx015ZsyguK3hc0I4476dibZ2c+xqf6pGU+SdqTLeDBgblZXdORlVL/jXHbe7MjUVJZ/o+5oEZqjCG5LYCBwMzU2JZ2i5CwV+VRmHjHoSPD+2isTkDVn4Tzb6jHUMtu6KJlMsKKGFtvk/VhwzEJSlJJAq+LjWwXMmFUmK5ncD8mgagg=="
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-06:00" level=debug msg="completed challenge"
Feb 24 06:17:02 volumio go-librespot[27690]: time="2026-02-24T06:17:02-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 06:17:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:04 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:04 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Feb 24 06:17:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:05 volumio go-librespot[27701]: go-librespot daemon starting...
Feb 24 06:17:05 volumio go-librespot[27702]: time="2026-02-24T06:17:05-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:05 volumio go-librespot[27702]: time="2026-02-24T06:17:05-06:00" level=debug msg="app state loaded"
Feb 24 06:17:05 volumio go-librespot[27702]: time="2026-02-24T06:17:05-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:05 volumio go-librespot[27702]: time="2026-02-24T06:17:05-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-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 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-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 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-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 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-06:00" level=info msg="zeroconf server listening on port 40953"
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-06:00" level=debug msg="obtained new client token: AACYvYe1SRYBMHYTGEHPFL+jWHTH+VbnbueIe4hPXveUe0XCdDoh3ylBU5VqxqlQh8iHJyRg1V5CyFTHdMxOz15XD4KqW6Jony12qGamZkjbzriEQCwhFoJLKSlFnuxgRecjBAdVdoZrw3/FKHtoBTLQDjXaCSAc5D2TvvEePZEOCxGBBGEjSEuHeUpOIU9JGLDq4/LWq9wZ/m4rXLgUkX7wAxeqqdbmEY9yAQMK7NzDMzGEnix1BNI="
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-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 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-06:00" level=debug msg="completed challenge"
Feb 24 06:17:06 volumio go-librespot[27702]: time="2026-02-24T06:17:06-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 06:17:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:07 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:07 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Feb 24 06:17:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:09 volumio go-librespot[27710]: go-librespot daemon starting...
Feb 24 06:17:09 volumio go-librespot[27711]: time="2026-02-24T06:17:09-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:09 volumio go-librespot[27711]: time="2026-02-24T06:17:09-06:00" level=debug msg="app state loaded"
Feb 24 06:17:09 volumio go-librespot[27711]: time="2026-02-24T06:17:09-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:09 volumio go-librespot[27711]: time="2026-02-24T06:17:09-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-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 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-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 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-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 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-06:00" level=info msg="zeroconf server listening on port 44621"
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-06:00" level=debug msg="obtained new client token: AAAV6jAuoS3Xh+/b1NvBOvel8iY04GZ/sCbmGPrgkv7raxHE8Q2vmiCpVy5JGJpP8ih3Iy3g7PPFLbL0P1xRicZvl6IkqImQSiVSbEKlWN9YpY+D6YjZ6yyoDOG7YxI2Shqla5XpKREuNPu1F3u8U2A9BA+CzvmZKvs5FWsBPHMDEzGRmg4JTv/J8LFEd+KpUUFvNTbCa6tFnRNNd0Oa3yFAlpGz4dMJC/IsgZ2/MNxrXC9+FqedtF4="
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-06:00" level=debug msg="completed challenge"
Feb 24 06:17:10 volumio go-librespot[27711]: time="2026-02-24T06:17:10-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 06:17:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:10 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:10 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:13 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:13 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Feb 24 06:17:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:13 volumio go-librespot[27732]: go-librespot daemon starting...
Feb 24 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-06:00" level=debug msg="app state loaded"
Feb 24 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-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 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-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 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-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 06:17:13 volumio go-librespot[27733]: time="2026-02-24T06:17:13-06:00" level=info msg="zeroconf server listening on port 42505"
Feb 24 06:17:14 volumio go-librespot[27733]: time="2026-02-24T06:17:14-06:00" level=debug msg="obtained new client token: AADub1JWYW8hanGyhXcN7yZhp2NO1FanI+8wkK4MTrTuBPTnH9RYrbUUz02SPztTpwLjIyGGYAAr8QwncOLtN051d+IF7wNKZ4xXf0EMcVBi5B166808TTP9Im4bL2LU3JJtG8l5fF87HDcX54rdYcnlKwwu9sgUxV+ylQb2iCxs0wV4oKw5Fqqcrozd5JHErKWrEOkQp1hOXeeNt0PyrKJr3kgXKlsV/J10PunES0c5D7vkfO5QeRs="
Feb 24 06:17:14 volumio go-librespot[27733]: time="2026-02-24T06:17:14-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:14 volumio go-librespot[27733]: time="2026-02-24T06:17:14-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:14 volumio go-librespot[27733]: time="2026-02-24T06:17:14-06:00" level=debug msg="completed challenge"
Feb 24 06:17:14 volumio go-librespot[27733]: time="2026-02-24T06:17:14-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 06:17:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:16 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:16 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Feb 24 06:17:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:17 volumio go-librespot[27740]: go-librespot daemon starting...
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="app state loaded"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-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 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-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 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-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 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=info msg="zeroconf server listening on port 33455"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="obtained new client token: AAD7x5VJgWfMebsKOXJ1DHZQmoHTtAGE4K5Q3tm1URMioOtFa7FWvcZ+r11970s+H75YFV950NHGl0k0Z02CMfZOGXEDeb0Puozs6F4FVxNOJhG0U1ywJTa4gNVtUdks2/aUtkCjfBMPaagPSHnBTQMgmGerVeNTuhjRIbwV+gamcGJAeC3KcIZkDT4WqLgW9VTHyKZ1zvAP7bVJn2k3aDK8eL0KMDzEfLj/wp7lLx6feypX//aG4a42Zw=="
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-06:00" level=debug msg="completed challenge"
Feb 24 06:17:17 volumio go-librespot[27741]: time="2026-02-24T06:17:17-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 06:17:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:19 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:19 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37.
Feb 24 06:17:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:21 volumio go-librespot[27763]: go-librespot daemon starting...
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="app state loaded"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-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 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-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 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-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 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=info msg="zeroconf server listening on port 44561"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="obtained new client token: AAD2b4akfRHoEovApYv4OoXJwF3pjTgK/sq89XLCbc9/AUnMMPItZtKMHsO0C90NbhaY8Lro9ddkiXSRhAvnhywll/E57yT4sh5R8oxXj/hBfYZ9qzrQR5/eZYg/AEPWbC8lylC7w72i3J2BzytT7h/1XvZwrDU4YYWu+3I+1jpUCWH7sxQyttKocbym3L+/ryJr5+zC+BEuWhB3ggETkzMW0tdG2cZkZN2XArwnIq66ejXdpTpge7iYXw=="
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-06:00" level=debug msg="completed challenge"
Feb 24 06:17:21 volumio go-librespot[27764]: time="2026-02-24T06:17:21-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 06:17:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:22 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:22 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38.
Feb 24 06:17:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:24 volumio go-librespot[27775]: go-librespot daemon starting...
Feb 24 06:17:24 volumio go-librespot[27776]: time="2026-02-24T06:17:24-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:24 volumio go-librespot[27776]: time="2026-02-24T06:17:24-06:00" level=debug msg="app state loaded"
Feb 24 06:17:24 volumio go-librespot[27776]: time="2026-02-24T06:17:24-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:24 volumio go-librespot[27776]: time="2026-02-24T06:17:24-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-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 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-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 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-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 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-06:00" level=info msg="zeroconf server listening on port 44351"
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-06:00" level=debug msg="obtained new client token: AAC/G5+PAsVPYsXNKwQMbZj6Bh8+/7pzTZmzYOZmUI2ZwVi+FHkifDc0rmXyRbhvDCPcYRgJnNot5e7Zizmdj1sSChzbLyyX+pnHDcE40Y+84SY3qZfCwMUQpWZlBpVIFlHUcrcGNKPlPtVfaHupsS11w2uY/ONoZP+tdZ8xFcWpL8FlddFlR8CoQJ+sH+x6KM9iMrIG2j4jHJySs/cgtzsRwYS8u/X+CAUyWrQxiY+fgCqNrma/DsRpPA=="
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-06:00" level=debug msg="completed challenge"
Feb 24 06:17:25 volumio go-librespot[27776]: time="2026-02-24T06:17:25-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 06:17:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:25 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:25 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:28 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:28 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39.
Feb 24 06:17:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:28 volumio go-librespot[27783]: go-librespot daemon starting...
Feb 24 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-06:00" level=debug msg="app state loaded"
Feb 24 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-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 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-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 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-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 06:17:28 volumio go-librespot[27784]: time="2026-02-24T06:17:28-06:00" level=info msg="zeroconf server listening on port 33509"
Feb 24 06:17:29 volumio go-librespot[27784]: time="2026-02-24T06:17:29-06:00" level=debug msg="obtained new client token: AACY0egzGV1daontfyuYnR4FZJ0VPmWVPE4QEdpoeYlDMUyQ/T5JqgnP5GnaqgoErp2+ePNN90oSj3YXRddnnr/rPNfDemM2pI4/IcAve5YvQH9VqQBcdB9VgrYdeIKfYg6V37xmecJzTuJAIwEC1au/ZdjjaRzkJ69qXGYqoUr3dN8D2d3a6LmjOigEDTc2Ny758DynYzLqFIY91vnD2GOpWsZCwmS0x/3amEv4K1KyqwXb/7FmwGQ="
Feb 24 06:17:29 volumio go-librespot[27784]: time="2026-02-24T06:17:29-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:29 volumio go-librespot[27784]: time="2026-02-24T06:17:29-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:29 volumio go-librespot[27784]: time="2026-02-24T06:17:29-06:00" level=debug msg="completed challenge"
Feb 24 06:17:29 volumio go-librespot[27784]: time="2026-02-24T06:17:29-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 06:17:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:31 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:31 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40.
Feb 24 06:17:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:32 volumio go-librespot[27805]: go-librespot daemon starting...
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=debug msg="app state loaded"
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-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 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-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 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-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 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=info msg="zeroconf server listening on port 37189"
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=debug msg="obtained new client token: AAC8z2IwbJA5ywxCC1Wicag6ApyXkiAbm6dy/W9NPmnAe7ZJpSFVCAescjft+NwT5K/tRXLO86kkT6OatjIDZypT1ealtHBlPQCEnmweJDB/LynZN1CTNYyGcuE13FwyXMNc9dkSRdBFEb64uhKLpRctcENfF4Nlc80juUdOPrvdXk3F2uPnC1NaPhBLlhNJ1DH7Dh00kPcB1J9e1cp/d9IJSqOIsdZPvBRb3U/np8slTbhnJL+cHi+x8w=="
Feb 24 06:17:32 volumio go-librespot[27806]: time="2026-02-24T06:17:32-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 24 06:17:33 volumio go-librespot[27806]: time="2026-02-24T06:17:33-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:33 volumio go-librespot[27806]: time="2026-02-24T06:17:33-06:00" level=debug msg="completed challenge"
Feb 24 06:17:33 volumio go-librespot[27806]: time="2026-02-24T06:17:33-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 06:17:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:34 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:34 volumio volumio[26915]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41.
Feb 24 06:17:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:37 volumio go-librespot[27813]: go-librespot daemon starting...
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="app state loaded"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-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 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-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 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-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 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=info msg="zeroconf server listening on port 34193"
Feb 24 06:17:37 volumio volumio[26915]: info: Initializing connection to go-librespot Websocket
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="new websocket client"
Feb 24 06:17:37 volumio volumio[26915]: info: Connection to go-librespot Websocket established
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="obtained new client token: AADn6I6RIEUJwwN4ZVvCD3YmA12rDvPPQsDR0/oXJXYKAxpSWsWTSvNO9gCtCaxCG7O/E8aCaGxJI87Gi8gf9vFuxaEXuU/UZZEyQ3akzBomQ7/NuudcZgic8fu7gBh7TwJbXnU6t6KaUJ/mT8WphW5/kPpwxQzsvweqyN47NUJEVoU6Tx8++iB7vM5cb0YEtNs/u2qIfPu/oP0uGtNuLophNgNTe5C0TpkYR+iz5qLBIkmE2t72RekhIA=="
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-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 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="completed keyexchange"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-06:00" level=debug msg="completed challenge"
Feb 24 06:17:37 volumio go-librespot[27814]: time="2026-02-24T06:17:37-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 06:17:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 06:17:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 24 06:17:37 volumio volumio[26915]: info: Connection to go-librespot Websocket closed
Feb 24 06:17:40 volumio volumio[26915]: info: Getting Spotify volume
Feb 24 06:17:40 volumio volumio[26915]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 06:17:40 volumio volumio[26915]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 24 06:17:40 volumio volumio[26915]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 24 06:17:40 volumio volumio[26915]: errno: -111,
Feb 24 06:17:40 volumio volumio[26915]: code: 'ECONNREFUSED',
Feb 24 06:17:40 volumio volumio[26915]: syscall: 'connect',
Feb 24 06:17:40 volumio volumio[26915]: address: '127.0.0.1',
Feb 24 06:17:40 volumio volumio[26915]: port: 9879,
Feb 24 06:17:40 volumio volumio[26915]: response: undefined
Feb 24 06:17:40 volumio volumio[26915]: }
Feb 24 06:17:40 volumio volumio[26915]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 06:17:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42.
Feb 24 06:17:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 24 06:17:40 volumio go-librespot[27847]: go-librespot daemon starting...
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:40-06:00" level=info msg="running go-librespot 0.4.0"
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=debug msg="app state loaded"
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=debug msg="stored credentials not found"
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-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 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-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 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-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 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=info msg="zeroconf server listening on port 38995"
Feb 24 06:17:41 volumio sudo[27857]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 06:16'
Feb 24 06:17:41 volumio sudo[27857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=debug msg="obtained new client token: AABOItzOK6OmKpdvL7CygcL867jWhS6zxdw8tceHxn+M1H5yWPCMILf3ybXyXf0SJsr5nBz15Vi4ohkconKsdr6gLMltRUH71HDLLSbjJE0CUm1h9m2y7QCYtUX8Z87deSwBgr0m5rnd3siPC/C30ka8cE9PivRYo2h2LGGoIraWl90PrycF2MiZ0asgX2eukPZhFP18KoM4d7vFKzKW54kYV2cX4UmBBbL8mTPYWBTQgUgkuGXATFoD6Q=="
Feb 24 06:17:41 volumio go-librespot[27848]: time="2026-02-24T06:17:41-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
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"