Feb 26 01:23:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 133.
Feb 26 01:23:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:00 volumio go-librespot[22970]: go-librespot daemon starting...
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="app state loaded"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-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 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-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 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-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 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=info msg="zeroconf server listening on port 35709"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="obtained new client token: AACoUDofw1/JiFaddo1HnYbo10PPC3nYSKCmCkJDbKiWvm3XIMHlQIOGomp+WcmMtG7hnQBCe3TWzNsFqBEJV1sSFjwdAIh6Nvr/FuUQauXiTKzGbUfFYR0hYqL6fuJOBYIPViKt8vGf7lDgFC8fAke0+qB2yNoECCiJ/JytTmKu7qr8NS9UOmgrnHVO7hVfaQAPiHCwAP5mzCZToVXeZPta8DboikBuVc/QOY9OKa1ExSAnkDdwZ/CM1Q=="
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-06:00" level=debug msg="completed challenge"
Feb 26 01:23:00 volumio go-librespot[22971]: time="2026-02-26T01:23:00-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 26 01:23:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:01 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:01 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 134.
Feb 26 01:23:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:03 volumio go-librespot[22978]: go-librespot daemon starting...
Feb 26 01:23:03 volumio go-librespot[22992]: time="2026-02-26T01:23:03-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:03 volumio go-librespot[22992]: time="2026-02-26T01:23:03-06:00" level=debug msg="app state loaded"
Feb 26 01:23:03 volumio go-librespot[22992]: time="2026-02-26T01:23:03-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:03 volumio go-librespot[22992]: time="2026-02-26T01:23:03-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=info msg="zeroconf server listening on port 41363"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="obtained new client token: AABBeLOaM0uiejEu3rZe+oaRNcgP9i4CMb2AkRdQ67Kzl0o1V3iHtvZigUC+xpVJB/FDOqhTD3+T5p9udmFr1yvFGQL0ZgidmzRLUPG2iCTvx4rD0/wQv3+dWL7uh1lHFF8GN6mUQCdqCUnSV4anUZ6X6rCIWgNr0HxfgZWwB/1SHzMfGcQtPJYopfQ5kiLqcEHf4F/stcAbnwzs4G7BHyp21hTtdOH0Q9PtV5iItdF6h/WbFEWTNL+vjQ=="
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-06:00" level=debug msg="completed challenge"
Feb 26 01:23:04 volumio go-librespot[22992]: time="2026-02-26T01:23:04-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 26 01:23:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin bluetooth to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin multiroom to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin metavolumio to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin cd_controller to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin qobuzconnect to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin smart_inputs to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: Adding plugin tidalconnect to MyMusic Plugins
Feb 26 01:23:04 volumio volumio[22497]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Feb 26 01:23:05 volumio volumio[22497]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Feb 26 01:23:05 volumio volumio[22497]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Feb 26 01:23:05 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 26 01:23:05 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 26 01:23:05 volumio volumio[22497]: info: Starting MyVolumio Remote Streaming Endpoints
Feb 26 01:23:05 volumio volumio[22497]: info: MyVolumio login type: Token
Feb 26 01:23:05 volumio volumio[22497]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Feb 26 01:23:05 volumio volumio[22497]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Feb 26 01:23:06 volumio volumio[22497]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 26 01:23:06 volumio volumio[22497]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 26 01:23:06 volumio volumio[22497]: info: Streaming services startup
Feb 26 01:23:06 volumio volumio[22497]: info: Starting Streaming Daemon
Feb 26 01:23:06 volumio sudo[23001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 26 01:23:06 volumio sudo[23001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 26 01:23:06 volumio volumio[22497]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 26 01:23:06 volumio sudo[23001]: pam_unix(sudo:session): session closed for user root
Feb 26 01:23:06 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:06 volumio volumio[22497]: error: Cannot start Volumio Streaming Daemon
Feb 26 01:23:06 volumio volumio[22497]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 26 01:23:06 volumio volumio[22497]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 26 01:23:06 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:06 volumio volumio[22497]: error: MyVolumio FAILED LOGIN: Invalid assertion format. 3 dot separated segments required.
Feb 26 01:23:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 135.
Feb 26 01:23:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:07 volumio go-librespot[23007]: go-librespot daemon starting...
Feb 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-06:00" level=debug msg="app state loaded"
Feb 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-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 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-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 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-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 26 01:23:07 volumio go-librespot[23008]: time="2026-02-26T01:23:07-06:00" level=info msg="zeroconf server listening on port 37351"
Feb 26 01:23:08 volumio go-librespot[23008]: time="2026-02-26T01:23:08-06:00" level=debug msg="obtained new client token: AACYoyVScNXs3mz0aIs7465g3ZHT554kTIfHFdy/mCbiR0YJE5aTwq27Sw1/9F5k5cilIcP+Z5MCgXVsrp0S35e287PT5Bpia1NwrlOMwo5juwewl1+95pXc9XTlEMCk0KIyjm/rVEGwM9Z5fr2Zq/hRRrrDlq+cTwM62AK2euHA1hrU6wLKw4WQCJPn3Yl5Zp/eXwJzd802n55mNPCGfVbel57hLjvBwN9sndok6+qc6cP15VeIal0="
Feb 26 01:23:08 volumio go-librespot[23008]: time="2026-02-26T01:23:08-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:08 volumio go-librespot[23008]: time="2026-02-26T01:23:08-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:08 volumio go-librespot[23008]: time="2026-02-26T01:23:08-06:00" level=debug msg="completed challenge"
Feb 26 01:23:08 volumio go-librespot[23008]: time="2026-02-26T01:23:08-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:09 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:09 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 136.
Feb 26 01:23:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:11 volumio go-librespot[23016]: go-librespot daemon starting...
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=debug msg="app state loaded"
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-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 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-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 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-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 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=info msg="zeroconf server listening on port 35961"
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=debug msg="obtained new client token: AABGZgQb3BYRu6N7YyTKec1LKpCA4CQsVwoEACS1pDdCeLpvHGoBw37l4jjywMJpBmCWbnf09oEXRO9AYkWZ6VdPe30IabU+104rXI/NsB41MPiShWZzhKMa3FtPRfcBaibuORoN+HxQlW/ld0Xl3c17aLrj6M2cKpzlOi8FpS7uDTSS46Lf2Z3l83daFNxmgpV0adzxA8QLtqCsnpo8erWoU/XlI5E4MSQK+RLLVUPl6WKB9uzmgxj2AQ=="
Feb 26 01:23:11 volumio go-librespot[23017]: time="2026-02-26T01:23:11-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:12 volumio go-librespot[23017]: time="2026-02-26T01:23:12-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:12 volumio go-librespot[23017]: time="2026-02-26T01:23:12-06:00" level=debug msg="completed challenge"
Feb 26 01:23:12 volumio go-librespot[23017]: time="2026-02-26T01:23:12-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:12 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:12 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:15 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:15 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 137.
Feb 26 01:23:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:15 volumio go-librespot[23038]: go-librespot daemon starting...
Feb 26 01:23:15 volumio go-librespot[23039]: time="2026-02-26T01:23:15-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:15 volumio go-librespot[23039]: time="2026-02-26T01:23:15-06:00" level=debug msg="app state loaded"
Feb 26 01:23:15 volumio go-librespot[23039]: time="2026-02-26T01:23:15-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:15 volumio go-librespot[23039]: time="2026-02-26T01:23:15-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-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 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-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 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=info msg="zeroconf server listening on port 34375"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=debug msg="obtained new client token: AACmRUUbUxi8yUmkqTTX1XRZnGdvSZfcnw10MSqX1rY1K/nMn3q9i9eXJbIwOyDOgfxMqhfSJAlBz5AJk+Oj6MMS/swxSioGq50PkpdMgmgJ54su3XLhKxXv+V1a6GQS6NWOCjrIbrBheCj00b+aEUqQcnPAmedBtRT4SJ2p/1S76pNwRC6DmrZO78hqt37Vy2TQDRRzWXyUFXACyCRWlXkPfy7UOWZNa8n7QcDJPU2BkVDh6JqsX8a6jw=="
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=debug msg="completed challenge"
Feb 26 01:23:16 volumio go-librespot[23039]: time="2026-02-26T01:23:16-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:18 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 26 01:23:18 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 26 01:23:18 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 26 01:23:18 volumio volumio-remote-updater[26837]: Test mode disabled
Feb 26 01:23:18 volumio volumio-remote-updater[26837]: Alpha mode disabled
Feb 26 01:23:18 volumio volumio-remote-updater[26837]: Alpha legacy test mode disabled
Feb 26 01:23:18 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 26 01:23:18 volumio volumio[22497]: 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 26 01:23:18 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 26 01:23:18 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:18 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 138.
Feb 26 01:23:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:19 volumio go-librespot[23054]: go-librespot daemon starting...
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=debug msg="app state loaded"
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-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 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-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 26 01:23:19 volumio go-librespot[23055]: time="2026-02-26T01:23:19-06:00" level=info msg="zeroconf server listening on port 38339"
Feb 26 01:23:20 volumio go-librespot[23055]: time="2026-02-26T01:23:20-06:00" level=debug msg="obtained new client token: AAA0mgwMap/G6LTOxgjJ0dVv7eRnOPZZk/1hqkTlH/3jYLyMWMuRTqn4reo6IPxi2Z4pvs0LN0n1kW1V7YYPtXA+1aMY9DSOl5ld+O9ntqYskjbSUB1ZP1QF3/s9U02CJnFQBupn5J4lYw8alnmKiziaYri/DUSe2enTTpC1yErkH54YV3rC6IAsuSqhkZ7D8oppgDorMf00LF6Ea4/J7jRq3kq8ufNzd4ytq52aE8P+GWCWUoFwnuc="
Feb 26 01:23:20 volumio go-librespot[23055]: time="2026-02-26T01:23:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:20 volumio go-librespot[23055]: time="2026-02-26T01:23:20-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:20 volumio go-librespot[23055]: time="2026-02-26T01:23:20-06:00" level=debug msg="completed challenge"
Feb 26 01:23:20 volumio go-librespot[23055]: time="2026-02-26T01:23:20-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:20 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 26 01:23:20 volumio volumio[22497]: 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 26 01:23:20 volumio volumio[22497]: info: CoreCommandRouter::volumioGetState
Feb 26 01:23:20 volumio volumio[22497]: info: CorePlayQueue::getTrack 0
Feb 26 01:23:21 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:21 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 139.
Feb 26 01:23:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:23 volumio go-librespot[23063]: go-librespot daemon starting...
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="app state loaded"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=info msg="zeroconf server listening on port 45499"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="obtained new client token: AABnKpv4ZL1aGpvHlo0r//qUTU39S1Q9Me334Xp9ViKZg+fgNX7DF0TGMRFNDHOq7SA3TFzPhZqza1UPmPnnbPdWhwKm3gj8bazQt9R8PkT5yyh+k0jwCRMubDESOmrmPbLhFnIApXrutQYW1u3GqSBy1ffLw9GufF6roZ1AxtuPEf4bDsolMwE1pRgj7sPc2+oxLEhBwilVFIJ14ZniSRurqMKO/NEUfRT1nv9CP5ZPsGYeUj0Z73bzQg=="
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-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 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=debug msg="completed challenge"
Feb 26 01:23:23 volumio go-librespot[23064]: time="2026-02-26T01:23:23-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:24 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:24 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 26 01:23:25 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 26 01:23:26 volumio volumio[22497]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 26 01:23:26 volumio volumio[22497]: info: Completed starting MyVolumio Plugin
Feb 26 01:23:26 volumio volumio[22497]: [Metrics] CommandRouter: 54s 955.36ms
Feb 26 01:23:26 volumio volumio[22497]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 26 01:23:26 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 26 01:23:26 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 26 01:23:26 volumio volumio[22497]: info: CoreCommandRouter::Close All Modals sent
Feb 26 01:23:26 volumio volumio[22497]: info: CoreCommandRouter::Close All Modals sent
Feb 26 01:23:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 140.
Feb 26 01:23:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:27 volumio go-librespot[23088]: go-librespot daemon starting...
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="app state loaded"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-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 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-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 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=info msg="zeroconf server listening on port 44185"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="obtained new client token: AABjxoHv2AAe24JFXc7f564kMZyq70AFyGdjP8mr6CL4W0XYatm2m4X5eThoMbyyJsMEjxjnR9GY6eDdJiqgiIGuWt13cy+JYeuxG1rlSuqbMq2mrh4+juce4oziZTX6p3HUz22do5hw9aZuLGRWK4PnXvEbMnQyvpnQRu6el4flpKzyMR4MtJSKw4C7DTQ49aWI4KPhmgzsiXzKNVl0j88tJYMMsQ7/NC2jskO+QwvcZSovPqwrSfTq9g=="
Feb 26 01:23:27 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 26 01:23:27 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-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 26 01:23:27 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=debug msg="completed challenge"
Feb 26 01:23:27 volumio go-librespot[23089]: time="2026-02-26T01:23:27-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:27 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:27 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 141.
Feb 26 01:23:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:30 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:30 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:30 volumio go-librespot[23099]: go-librespot daemon starting...
Feb 26 01:23:30 volumio go-librespot[23100]: time="2026-02-26T01:23:30-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:30 volumio go-librespot[23100]: time="2026-02-26T01:23:30-06:00" level=debug msg="app state loaded"
Feb 26 01:23:30 volumio go-librespot[23100]: time="2026-02-26T01:23:30-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:30 volumio go-librespot[23100]: time="2026-02-26T01:23:30-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=info msg="zeroconf server listening on port 37321"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="obtained new client token: AABSltRXpYDIV6CQzMA/J+zn/Yr1o7ErgYYwTC3D0ladd/oET2Hg6B3bBvhyj/7mQ+cLCSGnPx9IKnAxsrO202X4htLhhcEnPeqgXr6XaZ7IT1RiX1T8SHX2G4lmn/SitZ8ekaLEnOBHVBFo3GxsqIz9Pp8vUsXDDoSNQ7LGdylGdwsf3I8JxK4dtVmKpYtF+0gar25U5KUU//2GPIE6iLN7+52cuYEDvIdj3NDrPK975TIb40rUY/3c9g=="
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=debug msg="completed challenge"
Feb 26 01:23:31 volumio go-librespot[23100]: time="2026-02-26T01:23:31-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:33 volumio volumio[22497]: info: BOOT COMPLETED
Feb 26 01:23:33 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:33 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 142.
Feb 26 01:23:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:34 volumio go-librespot[23121]: go-librespot daemon starting...
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=debug msg="app state loaded"
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-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 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-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 26 01:23:34 volumio go-librespot[23122]: time="2026-02-26T01:23:34-06:00" level=info msg="zeroconf server listening on port 40745"
Feb 26 01:23:35 volumio go-librespot[23122]: time="2026-02-26T01:23:35-06:00" level=debug msg="obtained new client token: AADG9eUEcM4bE6bIRZgmlyfZkVlv/fjEPC2POtHR+0mFEMiT1J5Lg5r5tncfS4zcUaGVUzPGeyBXQNa7l2LsUgdJKZ4+FeYJ54ZGw6rcumEGeXV9DlcEsSvllOGep7n0D99uhgrQfmt3Y3KU7sU4Vz6xh3Du64LQGHv5o2JZqCE96pyadj3XLT2/ArzoGy7Rq3hVLPKWy63Gy93mcMPwFoxYoPm2fSymsSNAxdq74lztd9Oyb/lgo74="
Feb 26 01:23:35 volumio go-librespot[23122]: time="2026-02-26T01:23:35-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:35 volumio go-librespot[23122]: time="2026-02-26T01:23:35-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:35 volumio go-librespot[23122]: time="2026-02-26T01:23:35-06:00" level=debug msg="completed challenge"
Feb 26 01:23:35 volumio go-librespot[23122]: time="2026-02-26T01:23:35-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:36 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:36 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 143.
Feb 26 01:23:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:38 volumio go-librespot[23129]: go-librespot daemon starting...
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="app state loaded"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=info msg="zeroconf server listening on port 45379"
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="obtained new client token: AADs03tLWfUtl13ws0afALoNhBSMOJ6lPKr9m9HAfQSnGIa/v/f7ceYwNCJH3GE/lohqSJpZ3Bj5K9x39TEEiCQTu6TB6A0nrPNLc1POtWCH09fN/LLpya/doDX9vztkFUpjiuUuDa2HQXwoIWFnMzNWzs4TEFDO25ymfpmPjc9Y1yyJ89VhsXJ8zHMSnfIMiGip6aWPPriOY7CxR03H5eYJGq9i+dmtox2E8UAmKuJv0ZqVEzIrIEJj7Q=="
Feb 26 01:23:38 volumio go-librespot[23130]: time="2026-02-26T01:23:38-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:39 volumio go-librespot[23130]: time="2026-02-26T01:23:39-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:39 volumio go-librespot[23130]: time="2026-02-26T01:23:39-06:00" level=debug msg="completed challenge"
Feb 26 01:23:39 volumio go-librespot[23130]: time="2026-02-26T01:23:39-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 26 01:23:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:39 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:39 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 144.
Feb 26 01:23:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:42 volumio go-librespot[23140]: go-librespot daemon starting...
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="app state loaded"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-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 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-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 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=info msg="zeroconf server listening on port 35541"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="obtained new client token: AAC2GOW7FFcSIMF3iMZH53SDD9eWPzSCWmIHIL9quBZ/BYYfVlpZPZQ7vZlG53tsalrllvgWxQdmFg/3ntydRD3t8DsuFPN6j3I3tWUdwhboNEQv7vVzoH9us5/jGi2z+yTvFC7VwR2BVQYq/XyLzM4gQ7ENFPHwZdoXOrrHMf9KBmIMNTaayMyV0KEMTdU121BaEpm08lzGyyau7C+YCk+6Civn8NvppGoE0vsWPur1nGGwMVx9SY6J6A=="
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=debug msg="completed challenge"
Feb 26 01:23:42 volumio go-librespot[23141]: time="2026-02-26T01:23:42-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:42 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:42 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 145.
Feb 26 01:23:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:45 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:45 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:45 volumio go-librespot[23163]: go-librespot daemon starting...
Feb 26 01:23:45 volumio go-librespot[23164]: time="2026-02-26T01:23:45-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:45 volumio go-librespot[23164]: time="2026-02-26T01:23:45-06:00" level=debug msg="app state loaded"
Feb 26 01:23:45 volumio go-librespot[23164]: time="2026-02-26T01:23:45-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:45 volumio go-librespot[23164]: time="2026-02-26T01:23:45-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-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 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-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 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=info msg="zeroconf server listening on port 43965"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=debug msg="obtained new client token: AACEKWqhEtKuYi/RFUmSdXjPip2hfkIgE3o0/dXMpq01G5Zp21wHhg2UrQXZfd62ICyzdIUNPTzeyFSJhH8iIsli6VKBE8etPohwimUjJFg2b7aN8I0MvBfqoDjphZpiozmWitYkajKOntR2pZOPCmoZOec2rBtyDGeP1SAsjmX7Gd+NTRW7cR6YdLHlBy+1fbw/X4j/+cQEVV6LFe6c5rRZtKYAh5o8f1zRzAUE4Ny9N5SEnv+nVkk="
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=debug msg="completed challenge"
Feb 26 01:23:46 volumio go-librespot[23164]: time="2026-02-26T01:23:46-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:48 volumio volumio[22497]: info: UPDATER: Scheduling automatic update
Feb 26 01:23:48 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Feb 26 01:23:48 volumio volumio[22497]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Feb 26 01:23:48 volumio volumio[22497]: info: UPDATER: Auto update will take place at: Fri Feb 27 2026 05:51:36 GMT-0600 (Central Standard Time)
Feb 26 01:23:48 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:48 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 146.
Feb 26 01:23:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:49 volumio go-librespot[23172]: go-librespot daemon starting...
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=debug msg="app state loaded"
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-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 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-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 26 01:23:49 volumio go-librespot[23173]: time="2026-02-26T01:23:49-06:00" level=info msg="zeroconf server listening on port 38207"
Feb 26 01:23:50 volumio go-librespot[23173]: time="2026-02-26T01:23:50-06:00" level=debug msg="obtained new client token: AADrCJbKiPop/2idk3MoDNMXPbJg7vNZW/augcJ1DuLLkdV7XAeYS+3lNgsIfGdaSRjeywylPf+GPvqmOMHmgUAhVWcXiluPuaqCF8f1szBjpa4ytfoyrlcuXK655xKuc1/njB8VJ7TIggqiGOYpi4fzdvVsVkAybeGHPewTH4nudaFQ6V4FsR0QZGgSi+imbxJga4KFAwRR1/9fILQhQWhSLBL3UyD0S9NmNch4cpL7fNYALtOMPVs="
Feb 26 01:23:50 volumio go-librespot[23173]: time="2026-02-26T01:23:50-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:50 volumio go-librespot[23173]: time="2026-02-26T01:23:50-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:50 volumio go-librespot[23173]: time="2026-02-26T01:23:50-06:00" level=debug msg="completed challenge"
Feb 26 01:23:50 volumio go-librespot[23173]: time="2026-02-26T01:23:50-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:51 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:51 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 147.
Feb 26 01:23:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:53 volumio go-librespot[23180]: go-librespot daemon starting...
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="app state loaded"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-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 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-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 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=info msg="zeroconf server listening on port 41347"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="obtained new client token: AAC+xRuLGGZSgCFTcpuu1n5DfjHzBR7Zt4qYyO4QC+tNw09+djbVICdVPprhax/KDg0geChBFAokW3xS+l6lBjGUbszu/KSMcFUJqCIFKhi5EIj8YwjeR0ebiKIzOWw/ttlveF8RjGwV/SljJd7jwq09NO75VAuSRJtqKtI25rAECdvwkpb+J6xFVk80CnnADNW7PSVCkChK5Dez7lX/0YaXZkz1tUQoRZ1EhCI2mlqWSgH+q7y29vNOHg=="
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=debug msg="completed challenge"
Feb 26 01:23:53 volumio go-librespot[23181]: time="2026-02-26T01:23:53-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:54 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:54 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:23:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 148.
Feb 26 01:23:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:23:57 volumio go-librespot[23202]: go-librespot daemon starting...
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="app state loaded"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="stored credentials not found"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-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 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-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 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=info msg="zeroconf server listening on port 43919"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="obtained new client token: AAAxtTDqzfF0WpamoCcx3xtX3SQi14iyf4QVsX69wM84UFs2AgEtlBjAdksdDooRrIK9vycy+3FsnR+p/N5gGc6PWTjH/uMFmZHtzmtqGtG32qq9d1LVFb9g+rD/jhfqdiSCDxhabH9FW6rKW3lBBGJoHR3jRChb08VC44K6nlvaWE4p4014PnOIh09rq69X7WzcCYcrPThanoy+riZz42C2iURzXoPmeIKXbdlBwtWxNT8ZaAkF17iiug=="
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="completed keyexchange"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=debug msg="completed challenge"
Feb 26 01:23:57 volumio go-librespot[23203]: time="2026-02-26T01:23:57-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:23:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:23:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:23:57 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:23:57 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 149.
Feb 26 01:24:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:00 volumio go-librespot[23213]: go-librespot daemon starting...
Feb 26 01:24:00 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:00 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:00 volumio go-librespot[23214]: time="2026-02-26T01:24:00-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:00 volumio go-librespot[23214]: time="2026-02-26T01:24:00-06:00" level=debug msg="app state loaded"
Feb 26 01:24:00 volumio go-librespot[23214]: time="2026-02-26T01:24:00-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:00 volumio go-librespot[23214]: time="2026-02-26T01:24:00-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-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 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-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 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=info msg="zeroconf server listening on port 41755"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=debug msg="obtained new client token: AAAiSlly+1rwL3eHCzo+t8tnvUwu7TepYomaazUEtmPsGykTgMyW6E5kKyBWJWeDCC5R0acozq9GanJL7RcwWR0UgQ6GOrnSTl2x/vpOVvIXk/AAzmSF9zDZIykM8XmiuWRVk0m5vSmqizocfYRkVsyHk0rmLx5XQabaSxThT1Eg37HbIkQydWFqjDGegTZ8ZHOJuoi7qvwt3uNc0YTYq82AVlEiypokDNcCOuX3d+4rfrspWmWh4u3fQg=="
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=debug msg="completed keyexchange"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=debug msg="completed challenge"
Feb 26 01:24:01 volumio go-librespot[23214]: time="2026-02-26T01:24:01-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:24:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:24:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:24:03 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:03 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 150.
Feb 26 01:24:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:04 volumio go-librespot[23235]: go-librespot daemon starting...
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=debug msg="app state loaded"
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-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 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-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 26 01:24:04 volumio go-librespot[23236]: time="2026-02-26T01:24:04-06:00" level=info msg="zeroconf server listening on port 36419"
Feb 26 01:24:05 volumio go-librespot[23236]: time="2026-02-26T01:24:05-06:00" level=debug msg="obtained new client token: AABi/2Jd+T6GjTChBiWesJPe/yViMReOnSqg3Gp+rGUHoT0A9TxN/jwwTaU013dxDxZ9iQLbxJdDaQ0VHxfJ5VwFcpC6Pu3WTIuODlmsmpVtcWKafCRg/MsKMDAIpGkSbDJykgeFMSdp2u/XqagImeSHCHmLV9HpWkTnm4oNNYkVhToOdEkdT67DrtNTuR3FMjQ7aO7H2Xrgq+YlIHa52XtsIeFIFtk0yWPG5JU32fOPh3jL6Xv8e0E="
Feb 26 01:24:05 volumio go-librespot[23236]: time="2026-02-26T01:24:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:24:05 volumio go-librespot[23236]: time="2026-02-26T01:24:05-06:00" level=debug msg="completed keyexchange"
Feb 26 01:24:05 volumio go-librespot[23236]: time="2026-02-26T01:24:05-06:00" level=debug msg="completed challenge"
Feb 26 01:24:05 volumio go-librespot[23236]: time="2026-02-26T01:24:05-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:24:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:24:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:24:06 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:06 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 151.
Feb 26 01:24:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:08 volumio go-librespot[23244]: go-librespot daemon starting...
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="app state loaded"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-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 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-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 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=info msg="zeroconf server listening on port 40073"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="obtained new client token: AAAvFBH18aITkPzfcZ5D1yH+ueATOfA1AgQR1Dset6XoXfcgSG4g2XCWR+W6mqFOwki2bkdoVCj5P66S1FuWVDDL55EETwoJ99KtsTUL1KcmlaXJJYkD4RBJqQKINdlzw1cWkl4zgjm7PWK1anF45my/D8ugvjqGceC+DN8EBDybTYUcETHS/g5EbNKiBOHOMR7ipxaR8kXppDGyLrTy3PUd6eseWHg/IgpJvSJFLtBjHTIGHt+EHK0clw=="
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="completed keyexchange"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=debug msg="completed challenge"
Feb 26 01:24:08 volumio go-librespot[23245]: time="2026-02-26T01:24:08-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:24:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:24:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:24:09 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:09 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 152.
Feb 26 01:24:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:12 volumio go-librespot[23252]: go-librespot daemon starting...
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="app state loaded"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-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 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-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 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=info msg="zeroconf server listening on port 41781"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="obtained new client token: AAA7lsQOb0iwgvgDVYaz+roIp+F2vStZvHKuGxwfJYDmym4iXISvvsOvnYJNxYcIhKak6TQ4QJ6uRpjy5drP5ovGOSkCF63PWouYB7UC76rLMbpxRFTlgYXicNOglyeGHeMs9ah28JKWC+l/Naxd9RKQYLlGoHumI5f39MOppMghxMnEuYIxC8HjpHWkpO92vQh/vWUYEMsgBSr/xr62jV8drcH4FbSu0XLs168LJo8gkyJcJyn0w2yFDg=="
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="completed keyexchange"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=debug msg="completed challenge"
Feb 26 01:24:12 volumio go-librespot[23253]: time="2026-02-26T01:24:12-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:24:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:24:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:24:12 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:12 volumio volumio[22497]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 153.
Feb 26 01:24:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:15 volumio go-librespot[23274]: go-librespot daemon starting...
Feb 26 01:24:15 volumio go-librespot[23275]: time="2026-02-26T01:24:15-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:15 volumio go-librespot[23275]: time="2026-02-26T01:24:15-06:00" level=debug msg="app state loaded"
Feb 26 01:24:15 volumio go-librespot[23275]: time="2026-02-26T01:24:15-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:15 volumio go-librespot[23275]: time="2026-02-26T01:24:15-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:15 volumio volumio[22497]: info: Initializing connection to go-librespot Websocket
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="new websocket client"
Feb 26 01:24:16 volumio volumio[22497]: info: Connection to go-librespot Websocket established
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=info msg="zeroconf server listening on port 42809"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="obtained new client token: AABJLeqaUxJYUFGNEXOVHcur354MOHowXC/EseHEVrPaqAERKjpszLV0vX8OZ/bRgUnzb+i/ElAUwQXV8OVG9wN7hMpmjSHnvNeCTtnOlFfiM8K2s24IQHfHQoRp/57LobQnk0FaRjUzbil6xaxeews/02xagS3vZ2wmoLu201Q9A8JNlxQXHqYmiMylGT1leHXwG+NbMyEWTjXa6mLMExvrZC4HhDRGOtpj45w28Q6z7lzT7PHGLTE="
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="completed keyexchange"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=debug msg="completed challenge"
Feb 26 01:24:16 volumio go-librespot[23275]: time="2026-02-26T01:24:16-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 26 01:24:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 26 01:24:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 26 01:24:16 volumio volumio[22497]: info: Connection to go-librespot Websocket closed
Feb 26 01:24:19 volumio volumio[22497]: info: Getting Spotify volume
Feb 26 01:24:19 volumio volumio[22497]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 01:24:19 volumio volumio[22497]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 26 01:24:19 volumio volumio[22497]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 26 01:24:19 volumio volumio[22497]: errno: -111,
Feb 26 01:24:19 volumio volumio[22497]: code: 'ECONNREFUSED',
Feb 26 01:24:19 volumio volumio[22497]: syscall: 'connect',
Feb 26 01:24:19 volumio volumio[22497]: address: '127.0.0.1',
Feb 26 01:24:19 volumio volumio[22497]: port: 9879,
Feb 26 01:24:19 volumio volumio[22497]: response: undefined
Feb 26 01:24:19 volumio volumio[22497]: }
Feb 26 01:24:19 volumio volumio[22497]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 01:24:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 154.
Feb 26 01:24:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 26 01:24:19 volumio go-librespot[23297]: go-librespot daemon starting...
Feb 26 01:24:19 volumio go-librespot[23298]: time="2026-02-26T01:24:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 26 01:24:19 volumio go-librespot[23298]: time="2026-02-26T01:24:19-06:00" level=debug msg="app state loaded"
Feb 26 01:24:19 volumio go-librespot[23298]: time="2026-02-26T01:24:19-06:00" level=debug msg="stored credentials not found"
Feb 26 01:24:19 volumio go-librespot[23298]: time="2026-02-26T01:24:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 26 01:24:19 volumio sudo[23306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 01:23'
Feb 26 01:24:19 volumio sudo[23306]: 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"