Feb 21 01:42:00 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:00 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66.
Feb 21 01:42:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:02 volumio go-librespot[29195]: go-librespot daemon starting...
Feb 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42:02-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42:02-06:00" level=debug msg="app state loaded"
Feb 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42:02-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42:02-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42: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 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42: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 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42: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 21 01:42:02 volumio go-librespot[29196]: time="2026-02-21T01:42:02-06:00" level=info msg="zeroconf server listening on port 45135"
Feb 21 01:42:03 volumio go-librespot[29196]: time="2026-02-21T01:42:03-06:00" level=debug msg="obtained new client token: AAAckPz+sCXrR47E8hEPcktsH+JTOG+FYfVB5Uml+FsETO/wte9l5ZyESh82v9HGKgc/tfGGb+BqlE30+caoAlxW2zb0cqCIkxYTJrW0MZzhoQeKSCrh4O8qL/uKm4NOTPjJ0fZ8IwjNVmSLttgAtHJJ4U2GbtjrTxslQjXGDQKVjjCsJyeXKyFtu2lKDFnQBFXZPvFfU8KTYK3KQ0upSSqpA7A3HNgXN1fz2tia7orxlKwh9FLIxS4="
Feb 21 01:42:03 volumio go-librespot[29196]: time="2026-02-21T01:42:03-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:03 volumio go-librespot[29196]: time="2026-02-21T01:42:03-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:03 volumio go-librespot[29196]: time="2026-02-21T01:42:03-06:00" level=debug msg="completed challenge"
Feb 21 01:42:03 volumio go-librespot[29196]: time="2026-02-21T01:42:03-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 21 01:42:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:03 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:03 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:06 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:06 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67.
Feb 21 01:42:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:06 volumio go-librespot[29217]: go-librespot daemon starting...
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="app state loaded"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-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 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-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 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=info msg="zeroconf server listening on port 36445"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="obtained new client token: AAC/9MhoGM6otpVh3ugVY0G2AgpyuZ2o4tHE+0Hi8Ynv3qjyWwDh/6ZyzK7U5fz7K3KrIgXXUIh0yznmaOldnAEGyAC4hcPHehGhoQ6nV2DhiWmomvt8VUK2r50m2a58O40IyKXjUEwn2q8P4GZDG0korxucRQjy66vWV7yPn1WwNtYsz2LTQX8CnmBE3uRS45pCywey2mddld/BkfTqgKy1staeMlDInHQT5FHNwnJ+QMU1o4ZZImQLdg=="
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42:06-06:00" level=debug msg="completed challenge"
Feb 21 01:42:06 volumio go-librespot[29218]: time="2026-02-21T01:42: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 21 01:42:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:09 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 01:42:09 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 01:42:09 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 21 01:42:09 volumio volumio-remote-updater[24445]: Test mode disabled
Feb 21 01:42:09 volumio volumio-remote-updater[24445]: Alpha mode disabled
Feb 21 01:42:09 volumio volumio-remote-updater[24445]: Alpha legacy test mode disabled
Feb 21 01:42:09 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 21 01:42:09 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:09 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:09 volumio volumio[28686]: 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 21 01:42:09 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 21 01:42:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68.
Feb 21 01:42:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:10 volumio go-librespot[29232]: go-librespot daemon starting...
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="app state loaded"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-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 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-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 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=info msg="zeroconf server listening on port 35349"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="obtained new client token: AAB4n00RJuVQdesLZbWygoMlgnT3d5LNEnyEuB5kd58hnKucaHetsEcawK76Cj0cC+JrPjDoX7CceV0U8l38gDLmYECG7zX79YvCxP1SLHV+tsrQpBVE2KNMruc31G4gXQijg8yf2yhFW+quomicUt+b3xCAIdiWXCGxmasJATdjJ8NpozRTSBLxsqHiWryVBcvOPxw576JzBB6HNLHcbcrZ/NyedW0OVxy4IiRBCJ96qF8Xgx0mDBPPrw=="
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42:10-06:00" level=debug msg="completed challenge"
Feb 21 01:42:10 volumio go-librespot[29233]: time="2026-02-21T01:42: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 21 01:42:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:11 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 21 01:42:11 volumio volumio[28686]: 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 21 01:42:11 volumio volumio[28686]: info: CoreCommandRouter::volumioGetState
Feb 21 01:42:11 volumio volumio[28686]: info: CorePlayQueue::getTrack 0
Feb 21 01:42:12 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:12 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69.
Feb 21 01:42:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:13 volumio go-librespot[29241]: go-librespot daemon starting...
Feb 21 01:42:13 volumio go-librespot[29242]: time="2026-02-21T01:42:13-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:13 volumio go-librespot[29242]: time="2026-02-21T01:42:13-06:00" level=debug msg="app state loaded"
Feb 21 01:42:13 volumio go-librespot[29242]: time="2026-02-21T01:42:13-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:13 volumio go-librespot[29242]: time="2026-02-21T01:42:13-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-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 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-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 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-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 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-06:00" level=info msg="zeroconf server listening on port 43281"
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-06:00" level=debug msg="obtained new client token: AAA9qM5M6wz9e9iueYaqE61afVqTWvZHW0wAGmrKxQqrxmHkdXMpemzD7Qe70hYllxYgF7tQ6AwiZJXxzG9kcrzveGYn5jYjNYFJpLdkQVLGFwDNodvsVbSlmmi1Nihxaqyf1XMF5lIHPQVqFJxyNmqQiMvPKDw5hzjOCsIq+Xsq/n2HJh60tt6587BrHELusjss0AoEHYcn+/aQ/8fIfxeDjHJY1nrEbl7tvpsummOaDGE9RUP8o8g="
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42:14-06:00" level=debug msg="completed challenge"
Feb 21 01:42:14 volumio go-librespot[29242]: time="2026-02-21T01:42: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 21 01:42:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:15 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:15 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 21 01:42:16 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 01:42:17 volumio volumio[28686]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 21 01:42:17 volumio volumio[28686]: info: Completed starting MyVolumio Plugin
Feb 21 01:42:17 volumio volumio[28686]: [Metrics] CommandRouter: 55s 34.22ms
Feb 21 01:42:17 volumio volumio[28686]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 21 01:42:17 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 01:42:17 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 01:42:17 volumio volumio[28686]: info: CoreCommandRouter::Close All Modals sent
Feb 21 01:42:17 volumio volumio[28686]: info: CoreCommandRouter::Close All Modals sent
Feb 21 01:42:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70.
Feb 21 01:42:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:17 volumio go-librespot[29266]: go-librespot daemon starting...
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-06:00" level=debug msg="app state loaded"
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42: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-gew1.spotify.com:80]"
Feb 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-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 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-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 21 01:42:17 volumio go-librespot[29267]: time="2026-02-21T01:42:17-06:00" level=info msg="zeroconf server listening on port 40723"
Feb 21 01:42:18 volumio go-librespot[29267]: time="2026-02-21T01:42:18-06:00" level=debug msg="obtained new client token: AAC24uFQviBBWG7K7gX1V2owO2UVcF3QydUOHj8bi+50dyTKrZWP4lfZT/DkkisnOBtsJreywolvWsBNswRnQC+9WyESm6JcZ57WsSCpj0Z1lPa8SZ9Kw9eams+ltl4ZBkzRTN+FZu4AQ65Gd1mMWTNMWPVrC8DFS87SuCqyEGRiGd6EvHGQTch4878mAaBHyj8PexNMVzY7KnLQ5nUba55xl1S3YzTF3s7IJOdWXecyk5K+7Nr/284="
Feb 21 01:42:18 volumio go-librespot[29267]: time="2026-02-21T01:42:18-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:18 volumio go-librespot[29267]: time="2026-02-21T01:42:18-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:18 volumio go-librespot[29267]: time="2026-02-21T01:42:18-06:00" level=debug msg="completed challenge"
Feb 21 01:42:18 volumio go-librespot[29267]: time="2026-02-21T01:42:18-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 21 01:42:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:18 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 21 01:42:18 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 21 01:42:18 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 21 01:42:18 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:18 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:21 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:21 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71.
Feb 21 01:42:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:21 volumio go-librespot[29277]: go-librespot daemon starting...
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="app state loaded"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42: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 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42: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 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42: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 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=info msg="zeroconf server listening on port 45151"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="obtained new client token: AADHBQgAh+4d7UK9dOeJKkaDNatgndlOKP6fJ1yhrN0wf/ah2nG+fqWCEkvqQl5vz1bY4IOYesKkAI/+P4vkng6BS3QEmedkfYScH6Ffo9Nu8OR4nhzhi6rgyFOC42rxa6tKtzZf4NmWCZDskPYsOsXTfy5uImR0snWmMTXqB2OaYUfMIpoOtcq/WUnKGpa5bgOFL/oN4aovqaE2jg13e6fMTQZ9LgK8z5qAYJ17RKnuoHE/YlFkiHFixA=="
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42:21-06:00" level=debug msg="completed challenge"
Feb 21 01:42:21 volumio go-librespot[29278]: time="2026-02-21T01:42: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 21 01:42:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:24 volumio volumio[28686]: info: BOOT COMPLETED
Feb 21 01:42:24 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:24 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72.
Feb 21 01:42:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:25 volumio go-librespot[29299]: go-librespot daemon starting...
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="app state loaded"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42: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 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42: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 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42: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 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=info msg="zeroconf server listening on port 45547"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="obtained new client token: AAA/8FNpQU8QdRBhdXyE9vwXtfVYDlhoxzTR0qZSOmYsyMEZjS/0wGksyvYPdDDCMCSJL9R/EN2+ImR24HU7wIVjItFpd9F6u3KuSxeMlQWFVrwDIPB8Ak7bWkYe6xWqijRTlf0z3/vKYRlC9sZp1LQsoIYyEyU0J/sPclo3pBRRn58nEcZdRhBdKRWmKG7srqFHWjRvEDH16m0uKnMEKSPkd1oDVq5s34DVSsDWb0yz+9VT8v7mLuJT1Q=="
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42:25-06:00" level=debug msg="completed challenge"
Feb 21 01:42:25 volumio go-librespot[29300]: time="2026-02-21T01:42: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 21 01:42:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:27 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:27 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73.
Feb 21 01:42:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:28 volumio go-librespot[29307]: go-librespot daemon starting...
Feb 21 01:42:28 volumio go-librespot[29308]: time="2026-02-21T01:42:28-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:28 volumio go-librespot[29308]: time="2026-02-21T01:42:28-06:00" level=debug msg="app state loaded"
Feb 21 01:42:28 volumio go-librespot[29308]: time="2026-02-21T01:42:28-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:28 volumio go-librespot[29308]: time="2026-02-21T01:42:28-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-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 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-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 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-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 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-06:00" level=info msg="zeroconf server listening on port 45701"
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-06:00" level=debug msg="obtained new client token: AAArHHEbS4oCf0RzNoDeB2ZBPAZGJexwP7um6LqLZLqUBmnCslCrDiGzT3EElAMLAN6eWxzhelvXtuMHJSg0RaNhVIi9JlwQdlrSiDioJoC7Wcd4zL7De0HYPaAjY6gYjFfzbYbWxy2+fHSZ15tsWKDLOKqKbf1MSYoyubPvUokbBCGkNt0dq4w5wBj/37hbel/9KB4Ndodt/QeCT/62qEJiF49J5AJAY2GBX04mUcm2D8IMRcUlHBc="
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42:29-06:00" level=debug msg="completed challenge"
Feb 21 01:42:29 volumio go-librespot[29308]: time="2026-02-21T01:42: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 21 01:42:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:30 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:30 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74.
Feb 21 01:42:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:32 volumio go-librespot[29319]: go-librespot daemon starting...
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-06:00" level=debug msg="app state loaded"
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-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 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-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 21 01:42:32 volumio go-librespot[29320]: time="2026-02-21T01:42:32-06:00" level=info msg="zeroconf server listening on port 33449"
Feb 21 01:42:33 volumio go-librespot[29320]: time="2026-02-21T01:42:33-06:00" level=debug msg="obtained new client token: AABULEmyMZkPr85wxoVtU7fkG2OiWwWLL0R74JNCItIC31d1iGI8UGtzUe1o9Unsx0Eoi/Wb/S5MLZIQ6yYjyIkox/V9VXrcicWEjP2Kt7pLRGZmCCyWoTVEdmy7Iw4PfrpLaHCP1UkHrON2Wzz+EYD9Fkd7IYN08IE7nEsR55rq3I8/drB2/2FZlngRWCH6t/w13Q8j5AgTli2Yd80WBL/ZUE4PgECbIgjcuBYoTXz15Sq8O3NkbUU="
Feb 21 01:42:33 volumio go-librespot[29320]: time="2026-02-21T01:42:33-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:33 volumio go-librespot[29320]: time="2026-02-21T01:42:33-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:33 volumio go-librespot[29320]: time="2026-02-21T01:42:33-06:00" level=debug msg="completed challenge"
Feb 21 01:42:33 volumio go-librespot[29320]: time="2026-02-21T01:42: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 21 01:42:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:33 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:33 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:36 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:36 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75.
Feb 21 01:42:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:36 volumio go-librespot[29341]: go-librespot daemon starting...
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="app state loaded"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42: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-gew4.spotify.com:80]"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-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 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-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 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=info msg="zeroconf server listening on port 42559"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="obtained new client token: AAAFZBHs33ftpvPbW7UKKOmhmCSr9j08Oh0Day8kOsIdONL6uttYK3d73P/zCKs9hyIEnckL2g78VcOtW0xzJQz8ktd5m7512u33Ulr4G8bZDylZ+yOelVyhNR3W7IA61qiJuoeG+zkvyoSNh1gi4t6d+OnZ0Oa3YK8r2E8c5R3n8UaPUd+WRSaH5bf0h2p0xgIquqGKm6EHBFUU5Qntw7hXofGu1c/AvTHizFNAKGRkgO3CzFfAW8xwTQ=="
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42:36-06:00" level=debug msg="completed challenge"
Feb 21 01:42:36 volumio go-librespot[29342]: time="2026-02-21T01:42: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 21 01:42:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:39 volumio volumio[28686]: info: UPDATER: Scheduling automatic update
Feb 21 01:42:39 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Feb 21 01:42:39 volumio volumio[28686]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Feb 21 01:42:39 volumio volumio[28686]: info: UPDATER: Auto update will take place at: Sun Feb 22 2026 04:49:19 GMT-0600 (Central Standard Time)
Feb 21 01:42:39 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:39 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76.
Feb 21 01:42:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:40 volumio go-librespot[29349]: go-librespot daemon starting...
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="app state loaded"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-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 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-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 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-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 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=info msg="zeroconf server listening on port 45785"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="obtained new client token: AADaqusxyEaY7m4w/VJLRly/mtQqd7sTTTkgNPW8JaK3HS/6SMxW/3HxO+sFbUuj5jsSk+8Sak/6fVPuYZw/GmAFrMYzf154Hft7Xp95n9j/oH0FWMxlYN3BJ0DbUI5eV2AfLWoLRLj2zGd2+SyX3UD3QdpnD59uyN3YUIH6Ahxjq5Zw8uwE2oEGyB2ndzM4pBFFeqikJvBqC77MIYn8r1ST5dWGPz/1ZdfRc6fXQVuzZFw0nivGMxe2rw=="
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42:40-06:00" level=debug msg="completed challenge"
Feb 21 01:42:40 volumio go-librespot[29350]: time="2026-02-21T01:42: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 21 01:42:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:42 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:42 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77.
Feb 21 01:42:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:43 volumio go-librespot[29357]: go-librespot daemon starting...
Feb 21 01:42:43 volumio go-librespot[29358]: time="2026-02-21T01:42:43-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:43 volumio go-librespot[29358]: time="2026-02-21T01:42:43-06:00" level=debug msg="app state loaded"
Feb 21 01:42:43 volumio go-librespot[29358]: time="2026-02-21T01:42:43-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:43 volumio go-librespot[29358]: time="2026-02-21T01:42:43-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-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 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-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 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-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 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-06:00" level=info msg="zeroconf server listening on port 41717"
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-06:00" level=debug msg="obtained new client token: AABERHiYTNNUD+YIYJkSghBeH1YxOROiovxhLVGXee2c3YVte3RZHb+2hOfV7A2lWL56d1SXyj5AYwM0+16UZwhr3E8LCeG9nxA6SP0bi0cMuo7t8FS7rUB4ZVL9VJHXNNuIIJobOwWpE9Bz0IUBPjWgjJFi6CKkTA95QG6o5H6YILlWzl1tKPh/WiH0bBPdTknO9N8PlXrVBmcWVgk5DGrYrd57Pu/Dk54qE4ZjQBzHmi+aipNVlAk="
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-06:00" level=debug msg="completed challenge"
Feb 21 01:42:44 volumio go-librespot[29358]: time="2026-02-21T01:42:44-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 21 01:42:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:45 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:45 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78.
Feb 21 01:42:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:47 volumio go-librespot[29379]: go-librespot daemon starting...
Feb 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42:47-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42:47-06:00" level=debug msg="app state loaded"
Feb 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42:47-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42:47-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42: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 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42: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 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42: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 21 01:42:47 volumio go-librespot[29380]: time="2026-02-21T01:42:47-06:00" level=info msg="zeroconf server listening on port 44455"
Feb 21 01:42:48 volumio go-librespot[29380]: time="2026-02-21T01:42:48-06:00" level=debug msg="obtained new client token: AADTBTygwJ3THQwFBo5uXwufJO6X1qqJWBdEYnDw+tXK0t3LTeGCLBys+j9LwqcHQmbzCElvvm7RngqEbQrWtHQR8YYPXity9VXFlakAJ7nGjrB1qYOviUEHZHlTjkTcY6lBUWJpdDsB771YRmUhWyGz4wE/zfGUC8iiXrCFiIkzuMb3FMtrSsnfSHqJwS8Yt+3meSZHCrb6NBFS9TRXwlaiPMu2mKCFZWXegryAlO2jNJwIyQLZTgs="
Feb 21 01:42:48 volumio go-librespot[29380]: time="2026-02-21T01:42:48-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:48 volumio go-librespot[29380]: time="2026-02-21T01:42:48-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:48 volumio go-librespot[29380]: time="2026-02-21T01:42:48-06:00" level=debug msg="completed challenge"
Feb 21 01:42:48 volumio go-librespot[29380]: time="2026-02-21T01:42:48-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 21 01:42:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:48 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:48 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:51 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79.
Feb 21 01:42:51 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:51 volumio go-librespot[29390]: go-librespot daemon starting...
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="app state loaded"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-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 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-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 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=info msg="zeroconf server listening on port 34671"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="obtained new client token: AABtXjkckWwUM0pYbXXkTIyDgRk2bIAiPx4P55KCRgEzKNASVHoZEp5Tn1lkWwPR7mz3MnHNOwEJauGKxn1nIpdHTlfq71WHfvZ1CRz7DEmC8Awb3nl0t5AtbWfmsG7fsICaCLBNKHZqgpGu1wQMWw+NiTjCNYCRUBPKy0ggdUdhJrWbBJ2OuSYrMLGWu/vr7UXIk8VfFLjcxYnkmZ9/2M3yELT549fbk0aJ8JsMAkLhngbGHMZNx/1KOQ=="
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42:51-06:00" level=debug msg="completed challenge"
Feb 21 01:42:51 volumio go-librespot[29391]: time="2026-02-21T01:42: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 21 01:42:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:54 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:54 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80.
Feb 21 01:42:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:55 volumio go-librespot[29413]: go-librespot daemon starting...
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="app state loaded"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-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 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-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 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-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 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=info msg="zeroconf server listening on port 39319"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="obtained new client token: AABjRMGBIKcgoiQlf1MW1zliUGqfAD3WF/YXph+kSfs1NwdtLFJ55/ionIXtzBXK0ydFpFG5oZwFzoCNoIyWnPweRkFBVs4ixIkJ2uZKUBpOmJAGpPRpIaUo/txkz7KWRNjJNStiXoSXMWHVaEK7UU8tlNIZfBmCR9LPqksqWxk5wuv8XJtHfMSWXtNQxZkxzuoWi0FTJLTj0hRhiFTTu9SVkpgEECShhI/W9C5tkROF/DqRzSNnpDbAhQ=="
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-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 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42:55-06:00" level=debug msg="completed challenge"
Feb 21 01:42:55 volumio go-librespot[29414]: time="2026-02-21T01:42: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 21 01:42:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:42:57 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:42:57 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:42:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81.
Feb 21 01:42:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:42:58 volumio go-librespot[29421]: go-librespot daemon starting...
Feb 21 01:42:58 volumio go-librespot[29422]: time="2026-02-21T01:42:58-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:42:58 volumio go-librespot[29422]: time="2026-02-21T01:42:58-06:00" level=debug msg="app state loaded"
Feb 21 01:42:58 volumio go-librespot[29422]: time="2026-02-21T01:42:58-06:00" level=debug msg="stored credentials not found"
Feb 21 01:42:58 volumio go-librespot[29422]: time="2026-02-21T01:42:58-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-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 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-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 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-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 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-06:00" level=info msg="zeroconf server listening on port 39879"
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-06:00" level=debug msg="obtained new client token: AABgEBCJxpX4x3zfV928Rkmo4Kau/jpd1JD77BBGZ+skbhCYYWV9neWBlD8QolxnQ9xCW2uMkQY4xCigVkB7wSY6kj5jOGu9qshwB44uTZ03Jscj4lWVE6Ei1pzzt35JrB0xMvfG03l/atEV8GS9eCP5HyCuNltahFCcN+5+uVbuVN3uue8sI6o+hIcBSjWcUEM70jBrKyyOfiKG32hOzF4NAF7X9PFtbZAIjgpD2U53vDC9rL6R2G3bAg=="
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-06:00" level=debug msg="completed keyexchange"
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-06:00" level=debug msg="completed challenge"
Feb 21 01:42:59 volumio go-librespot[29422]: time="2026-02-21T01:42:59-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 21 01:42:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:42:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:00 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:00 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82.
Feb 21 01:43:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:02 volumio go-librespot[29429]: go-librespot daemon starting...
Feb 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43:02-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43:02-06:00" level=debug msg="app state loaded"
Feb 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43:02-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43:02-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43: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 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43: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 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43: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 21 01:43:02 volumio go-librespot[29430]: time="2026-02-21T01:43:02-06:00" level=info msg="zeroconf server listening on port 45415"
Feb 21 01:43:03 volumio go-librespot[29430]: time="2026-02-21T01:43:03-06:00" level=debug msg="obtained new client token: AADiln7crQ/tHIFNP10+9vACTJjbwGQvVkcaF5CsGRw2yjBt8oN0Zddjbz/rVmqgwR7BxQDGm/OmdajxkPoS7hFYubAjbqlyZ4lUkzRLTZyOxwaE35W5FsnNKT1zUtNzRnCBFTrETGxjx0TySGgXYoUJn1SQ38msyermy5C8jLfV37X92mYaDFrJhsYmzY+hEXJ31369uuaJI9cO0ZFPuIQ3aWque+HTputnq1ekhHgPRUzmO+4Wh3M="
Feb 21 01:43:03 volumio go-librespot[29430]: time="2026-02-21T01:43:03-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:03 volumio go-librespot[29430]: time="2026-02-21T01:43:03-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:03 volumio go-librespot[29430]: time="2026-02-21T01:43:03-06:00" level=debug msg="completed challenge"
Feb 21 01:43:03 volumio go-librespot[29430]: time="2026-02-21T01:43:03-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 21 01:43:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:03 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:03 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83.
Feb 21 01:43:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:06 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:06 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:06 volumio go-librespot[29451]: go-librespot daemon starting...
Feb 21 01:43:06 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="app state loaded"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-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 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-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 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=info msg="zeroconf server listening on port 41335"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="obtained new client token: AACGDrkuugW8jIwXnIMn1Bjzp7H4zhWDRt9hW6C2TScPaOX82/wB4LXdABF94D9Rw3SjCj+YAY1GsqWRzoxKpTDKC+olcp1PqpxfHAaZ0EdIPsYyxlFtqgUaq2cKpIGFdHnhTa85gHJY87rtvxqTjuz8fQAX5VMqSp8uE7fVmz0rP5mPqrLrpiFM/QfteUEF3+JpvxjDxKl2L+4S0MQVHlgCRm6AfLdJiZUg7VQbhJLAvNC7P6KhtWrurw=="
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:06 volumio go-librespot[29452]: time="2026-02-21T01:43:06-06:00" level=debug msg="completed challenge"
Feb 21 01:43:07 volumio go-librespot[29452]: time="2026-02-21T01:43:07-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 21 01:43:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:07 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 21 01:43:07 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 21 01:43:09 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:09 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84.
Feb 21 01:43:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:10 volumio go-librespot[29488]: go-librespot daemon starting...
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="app state loaded"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-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 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-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 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=info msg="zeroconf server listening on port 44315"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="obtained new client token: AABjQZVOnCSjnVjtxiKtC61UMSW94RQJ82OqBWo9OXiX5ruitDzose9QKw84Hvr3PrI1mERX2zHpobS8sfMbCLr6VU820m4ZB5gsQ84UfmsGHTUFf7v1SRVR7W0tynIy1f8NBq0USOalMgYZefpJLw6VRtfNPWinhFeeJ61vCF+agQCvJe1vZ5dW1g1yv1+TY91BbvucRwH9V8oaLgYesbpsQCdKIbNYtKuTHookOHj2ytrpexmJ41d8NQ=="
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43:10-06:00" level=debug msg="completed challenge"
Feb 21 01:43:10 volumio go-librespot[29489]: time="2026-02-21T01:43: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 21 01:43:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:12 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:12 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85.
Feb 21 01:43:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:13 volumio go-librespot[29496]: go-librespot daemon starting...
Feb 21 01:43:13 volumio go-librespot[29497]: time="2026-02-21T01:43:13-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:13 volumio go-librespot[29497]: time="2026-02-21T01:43:13-06:00" level=debug msg="app state loaded"
Feb 21 01:43:13 volumio go-librespot[29497]: time="2026-02-21T01:43:13-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:13 volumio go-librespot[29497]: time="2026-02-21T01:43:13-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-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 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-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 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-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 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-06:00" level=info msg="zeroconf server listening on port 46595"
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-06:00" level=debug msg="obtained new client token: AABZVb73GmH4DVhtl0fY8RpE24doO16Qr7G2a3mU0472hBFYa3pKLFT1raL4AaICrjef/lNA0ZbY8aBbjdZKyO6eRlh2hITbFw701/FuVP3pEylfmnpbUps/iGWMN2giGwJ32ToqVD/cPV5H2qG3SZA3ZTpcmILJ1I31gsGJZ6lJUgqn+VW/zx7LdACJX/RRFoQwakzVbPWg5pVgGM88xL8DmLiZLgkNzaac5tS6/v5trnQ6WmTq2FUshA=="
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-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 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43:14-06:00" level=debug msg="completed challenge"
Feb 21 01:43:14 volumio go-librespot[29497]: time="2026-02-21T01:43: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 21 01:43:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:15 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:15 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86.
Feb 21 01:43:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:17 volumio go-librespot[29520]: go-librespot daemon starting...
Feb 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43:17-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43:17-06:00" level=debug msg="app state loaded"
Feb 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43:17-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43:17-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43: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 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43: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 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43: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 21 01:43:17 volumio go-librespot[29521]: time="2026-02-21T01:43:17-06:00" level=info msg="zeroconf server listening on port 37987"
Feb 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-06:00" level=debug msg="obtained new client token: AACIkEEIiIijmVeEtwLNlE/eEwwko2y4C7pfwPJ/vWJMqo9ESxn1EwaSNxv0Mye4oKtRanJnUQ7aaFtPiKXUAx9H3re9EetKod9dzDcEjs4C3b80ma+nH3YV3RHwXDsWPmbOXfPTpnOoBon9pFab0XbSTLalUX5LWXTs+owxD1li0YPE75v6v39psPEtZ5jUkqMy18NHd3CrXEsuzAaS8IHVbXpH3nLLVji+OSFz7EjAJdkgUsuewjg="
Feb 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-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 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-06:00" level=debug msg="completed challenge"
Feb 21 01:43:18 volumio go-librespot[29521]: time="2026-02-21T01:43:18-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 21 01:43:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:18 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:18 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87.
Feb 21 01:43:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:21 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:21 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:21 volumio go-librespot[29528]: go-librespot daemon starting...
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="app state loaded"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-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 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-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 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=info msg="zeroconf server listening on port 46489"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="obtained new client token: AADk3KMV2lAtP7Y5BICG7txyUg+iKPoivm6w4wpduATJ7Ay3xe908x8nKGzL8JjlRB4TXI/S+e+WfMzwm0QWH78vRQjtdnHOsAEr8MmvY4RqGwWU5rEuaX9R3V87PnUg09yXpYk3O2L9uwivmzqCA7bom/C+yRMQxWe84bKiBxNLDrbx29wSFz4cui6JoSUS6/5B8afrJx6msSsX7ytzZ4B5zUwNY7gwBZ4zum01adgsaxAAwo2KjVE6qw=="
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43:21-06:00" level=debug msg="completed challenge"
Feb 21 01:43:21 volumio go-librespot[29529]: time="2026-02-21T01:43: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 21 01:43:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:24 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:24 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88.
Feb 21 01:43:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:25 volumio go-librespot[29550]: go-librespot daemon starting...
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="app state loaded"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-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 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-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 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=info msg="zeroconf server listening on port 36255"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="obtained new client token: AACRixvrft2PUHdhjK3jA4Dr+j4bXCy+VuUtDWW4guubIt5li28jxicu64hlX+LqktPE98Yu2TKZ3cg/4lChB7+vab9mUMS72/SGs/d1TE2gslFPwYk16hFqY7oht0R4VJzWMwHIrWZ+xGz55YAJC6x6lCiKZb9EDtclHphLBb32R+TEb6cjfo1TQPeTjBPbqO/GQyXlUywsiHM3LxWWdpTN0Kh04qTVtuKbkW83linB5pGLTVnxciP0cQ=="
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43:25-06:00" level=debug msg="completed challenge"
Feb 21 01:43:25 volumio go-librespot[29551]: time="2026-02-21T01:43: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 21 01:43:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:27 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:27 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89.
Feb 21 01:43:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:28 volumio go-librespot[29559]: go-librespot daemon starting...
Feb 21 01:43:28 volumio go-librespot[29560]: time="2026-02-21T01:43:28-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:28 volumio go-librespot[29560]: time="2026-02-21T01:43:28-06:00" level=debug msg="app state loaded"
Feb 21 01:43:28 volumio go-librespot[29560]: time="2026-02-21T01:43:28-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:28 volumio go-librespot[29560]: time="2026-02-21T01:43:28-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-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 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-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 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-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 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-06:00" level=info msg="zeroconf server listening on port 33797"
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-06:00" level=debug msg="obtained new client token: AACyvCRPHZPeO+/jCBBPE4dlpu5XBlnjAwQljZLPrDeB/s8ts5IBwq69NTfyeyqJ78j0zPWjXxwFKjazyHW7JPSh/gzuIvKmSPYMme8KUuZiQp00C46uNdDxC/INTkNzhk5dOMVDI1G0ljWIW4v/dXUF9lEF55zBrIkNkEHd6ZELCodFUF5DWYPj5hK/Lwe/ZGTQQIilKbsfSq8FY1J3TE5uE0+qRV+MFp864/AE8d2PHPsrdJuuD7U="
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43:29-06:00" level=debug msg="completed challenge"
Feb 21 01:43:29 volumio go-librespot[29560]: time="2026-02-21T01:43: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 21 01:43:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:30 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:30 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90.
Feb 21 01:43:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:32 volumio go-librespot[29570]: go-librespot daemon starting...
Feb 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43:32-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43:32-06:00" level=debug msg="app state loaded"
Feb 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43:32-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43:32-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43: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 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43: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 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43: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 21 01:43:32 volumio go-librespot[29571]: time="2026-02-21T01:43:32-06:00" level=info msg="zeroconf server listening on port 35425"
Feb 21 01:43:33 volumio go-librespot[29571]: time="2026-02-21T01:43:33-06:00" level=debug msg="obtained new client token: AAA+9oicUHV0LpDuwlB1+HQhowLwi+dA/zREOqzUFsZACYxItijdu6W44BklJu/zN+d2Gvy2Kz85o3i2zyGJFfgZPc9r6Svkw2ep9DRiuTWFVA0bP2R72Eic6NEr+ZeHnbOg/Ap/eegmIisdxddjg1RXJ/P9biQbsO1G5m3Va9vc7SdOOqaCQbzvR+RkR5SGCDy8c9eiefwFc7pn6Vg2TaKiv+M+8AfcMnvcN2FhW+BUBqqSoG3NhfE="
Feb 21 01:43:33 volumio go-librespot[29571]: time="2026-02-21T01:43:33-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:33 volumio go-librespot[29571]: time="2026-02-21T01:43:33-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:33 volumio go-librespot[29571]: time="2026-02-21T01:43:33-06:00" level=debug msg="completed challenge"
Feb 21 01:43:33 volumio go-librespot[29571]: time="2026-02-21T01:43: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 21 01:43:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:33 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:33 volumio volumio[28686]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91.
Feb 21 01:43:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:36 volumio go-librespot[29593]: go-librespot daemon starting...
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="app state loaded"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:36 volumio volumio[28686]: info: Initializing connection to go-librespot Websocket
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="new websocket client"
Feb 21 01:43:36 volumio volumio[28686]: info: Connection to go-librespot Websocket established
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-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 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-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 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=info msg="zeroconf server listening on port 42853"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="obtained new client token: AACH2+QsTJP2lMhAwuK8hCADV/0L45QJAuUhjoM+MeCQeiR0KQNesdjp6odgUhYfOi3qEwaMavkyoAolRyTwAXVd3jdYZCnJWlTYd+DUdOiiQLWmomSFXlBY3Q6+E9qfryD421GOo91FrbtS/8CVO9YmTYytTYrk98J4eimPPXt8KpHfN8xyUfwsWma/cQSloDdJU4e7j/mc+OgwEWsTsDEIADYJawH+d1MKXG5me34t3t+pN0E9rEumJg=="
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="completed keyexchange"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43:36-06:00" level=debug msg="completed challenge"
Feb 21 01:43:36 volumio go-librespot[29594]: time="2026-02-21T01:43: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 21 01:43:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 01:43:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 21 01:43:36 volumio volumio[28686]: info: Connection to go-librespot Websocket closed
Feb 21 01:43:39 volumio volumio[28686]: info: Getting Spotify volume
Feb 21 01:43:39 volumio volumio[28686]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 01:43:39 volumio volumio[28686]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 21 01:43:39 volumio volumio[28686]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 21 01:43:39 volumio volumio[28686]: errno: -111,
Feb 21 01:43:39 volumio volumio[28686]: code: 'ECONNREFUSED',
Feb 21 01:43:39 volumio volumio[28686]: syscall: 'connect',
Feb 21 01:43:39 volumio volumio[28686]: address: '127.0.0.1',
Feb 21 01:43:39 volumio volumio[28686]: port: 9879,
Feb 21 01:43:39 volumio volumio[28686]: response: undefined
Feb 21 01:43:39 volumio volumio[28686]: }
Feb 21 01:43:39 volumio volumio[28686]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 01:43:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92.
Feb 21 01:43:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 21 01:43:40 volumio go-librespot[29614]: go-librespot daemon starting...
Feb 21 01:43:40 volumio go-librespot[29615]: time="2026-02-21T01:43:40-06:00" level=info msg="running go-librespot 0.4.0"
Feb 21 01:43:40 volumio go-librespot[29615]: time="2026-02-21T01:43:40-06:00" level=debug msg="app state loaded"
Feb 21 01:43:40 volumio go-librespot[29615]: time="2026-02-21T01:43:40-06:00" level=debug msg="stored credentials not found"
Feb 21 01:43:40 volumio go-librespot[29615]: time="2026-02-21T01:43:40-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 01:43:40 volumio sudo[29623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-21 01:42'
Feb 21 01:43:40 volumio sudo[29623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="ac7dd5922ede329d1459d48b226ddc71f5209a2c"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Nov 13 11:04:27 UTC 2025"
VOLUMIO_VERSION="4.069"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="7da8d6d9f8baf8621af4ec2af5a00f00"