Feb 25 04:39:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23.
Feb 25 04:39:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:01 volumio go-librespot[23147]: go-librespot daemon starting...
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="app state loaded"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39: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-gew1.spotify.com:80]"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-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 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-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 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=info msg="zeroconf server listening on port 34607"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="obtained new client token: AAC00OvxKa7S+fpnUCUpBPujAhNmXzRt5NuUfQCW9Dgt1ojpsXo3Z0kXNLWX0adrAPmGZNX7fEZwcDuxmH8UfEtE1Dlk+B26bN4nNVB2iweDs9VRc4CstTxZXqFhBeQ6Zr8u90SHToQl1Kp7gMZaMdwcIJ2SW8rr+epQfLs/PkF/BrsBfvsD9i+UBYJmpHauTIsiXHGhZemVfddCpPeCNU5U8W+JT9IAvfFvhVOvNHKEhYTCP4DWFEAyeQ=="
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39:01-06:00" level=debug msg="completed challenge"
Feb 25 04:39:01 volumio go-librespot[23148]: time="2026-02-25T04:39: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 25 04:39:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin bluetooth to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin multiroom to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin metavolumio to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin cd_controller to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin qobuzconnect to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin smart_inputs to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: Adding plugin tidalconnect to MyMusic Plugins
Feb 25 04:39:01 volumio volumio[22656]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Feb 25 04:39:02 volumio volumio[22656]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Feb 25 04:39:02 volumio volumio[22656]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Feb 25 04:39:02 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 04:39:02 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 04:39:02 volumio volumio[22656]: info: Starting MyVolumio Remote Streaming Endpoints
Feb 25 04:39:02 volumio volumio[22656]: info: MyVolumio login type: Token
Feb 25 04:39:03 volumio volumio[22656]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Feb 25 04:39:03 volumio volumio[22656]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Feb 25 04:39:03 volumio volumio[22656]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 25 04:39:03 volumio volumio[22656]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 25 04:39:03 volumio volumio[22656]: info: Streaming services startup
Feb 25 04:39:03 volumio volumio[22656]: info: Starting Streaming Daemon
Feb 25 04:39:03 volumio sudo[23156]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 25 04:39:03 volumio sudo[23156]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 25 04:39:03 volumio volumio[22656]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 25 04:39:03 volumio sudo[23156]: pam_unix(sudo:session): session closed for user root
Feb 25 04:39:03 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:03 volumio volumio[22656]: error: Cannot start Volumio Streaming Daemon
Feb 25 04:39:03 volumio volumio[22656]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 25 04:39:03 volumio volumio[22656]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 25 04:39:03 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:04 volumio volumio[22656]: error: MyVolumio FAILED LOGIN: Invalid assertion format. 3 dot separated segments required.
Feb 25 04:39:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Feb 25 04:39:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:04 volumio go-librespot[23162]: go-librespot daemon starting...
Feb 25 04:39:04 volumio go-librespot[23163]: time="2026-02-25T04:39:04-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:04 volumio go-librespot[23163]: time="2026-02-25T04:39:04-06:00" level=debug msg="app state loaded"
Feb 25 04:39:04 volumio go-librespot[23163]: time="2026-02-25T04:39:04-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:04 volumio go-librespot[23163]: time="2026-02-25T04:39:04-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-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 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-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 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=info msg="zeroconf server listening on port 44867"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=debug msg="obtained new client token: AACVHZ8jerlS3WZaoplTwB3zz7vsyPwNWFJ8T75hXmAPN5T+EKwYRdHu0TJOiU+lJTCUIsAG/TCe8x/GgYzdIj49e29tUiWBNHAr3Tz1aHXH0QP4jsDTUq2XpBSowpd/GNYZe2lNEC0QkaGbyRhKB8kPpO2IVjNNIhQtLVeSm04V2WgY+Oh9uq5uhtzBHFTq77zd/H3trwTMDYeDgEQDgQ+IJ7DpV6/+05OnjdhTj34bI/GWVMU16m1eDg=="
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39:05-06:00" level=debug msg="completed challenge"
Feb 25 04:39:05 volumio go-librespot[23163]: time="2026-02-25T04:39: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 25 04:39:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:06 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:06 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25.
Feb 25 04:39:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:08 volumio go-librespot[23171]: go-librespot daemon starting...
Feb 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39:08-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39:08-06:00" level=debug msg="app state loaded"
Feb 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39:08-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39:08-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39: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 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39: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 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39: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 25 04:39:08 volumio go-librespot[23172]: time="2026-02-25T04:39:08-06:00" level=info msg="zeroconf server listening on port 36695"
Feb 25 04:39:09 volumio go-librespot[23172]: time="2026-02-25T04:39:09-06:00" level=debug msg="obtained new client token: AADKVwQjTvMEWTV1rDYHsaUfMy/ZYZcA739HFH6Q0Lh0bb1LWSyiqFCJ80WWPbFqEx14rIZoi2r9jk99hQDBeOcToUk8gnxnXyfKFxdBIzfVQ/NRV73Zgra+oD071KS0+iamED8jH0cbzhxDHQ/nXr5Zhs3bwaT7fJ76hJ5eR1e1Hx73KaqbYIpzq6uigzhKHBWzkUTbnakMzJPHfzT1mlhmtTXVNYsakxD5s3bkag3uPjWK9HsT5HE="
Feb 25 04:39:09 volumio go-librespot[23172]: time="2026-02-25T04:39:09-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:09 volumio go-librespot[23172]: time="2026-02-25T04:39:09-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:09 volumio go-librespot[23172]: time="2026-02-25T04:39:09-06:00" level=debug msg="completed challenge"
Feb 25 04:39:09 volumio go-librespot[23172]: time="2026-02-25T04:39:09-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 25 04:39:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:09 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:09 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Feb 25 04:39:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:12 volumio go-librespot[23193]: go-librespot daemon starting...
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="app state loaded"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-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 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-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 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=info msg="zeroconf server listening on port 45675"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="obtained new client token: AAByMjQoH4uIgxClDQ94NNqGTvU87Wz1J5b5uqvuzomCPTTbnXIT/kX1MS+K34wNamVodRBcF7UFpzAUAmSNOiVvm2kV309YY+lfABbo4bdR4EYOX0BA1CuPf90KnJNjGX/Lfy1T2mkxW9qHYNbyeaFE61lPy6avyD/3TNFnk5OLYKY9PT8sguwkCzsj84pIlMYcGo08mrUXMD9d4pYvMKMpC5QJp6J1eycVx/CsYtQzP6iz//vR9NFgOQ=="
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39:12-06:00" level=debug msg="completed challenge"
Feb 25 04:39:12 volumio go-librespot[23194]: time="2026-02-25T04:39: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 25 04:39:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:13 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:13 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:15 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 04:39:15 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 04:39:15 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 25 04:39:15 volumio volumio-remote-updater[26837]: Test mode disabled
Feb 25 04:39:15 volumio volumio-remote-updater[26837]: Alpha mode disabled
Feb 25 04:39:15 volumio volumio-remote-updater[26837]: Alpha legacy test mode disabled
Feb 25 04:39:15 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 25 04:39:15 volumio volumio[22656]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for CPU utilization spike
\nFix for triggerhappy input permission
\n
\nNEW ADDITIONS
\n\nAdd BLE onboarding plugin
\nEnable vc4-kms-v3d for all compatible RPi models
\nUpdate Tidal SDK
\n\n","title":"Update v4.096","updateavailable":true}
Feb 25 04:39:16 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 25 04:39:16 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:16 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Feb 25 04:39:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:16 volumio go-librespot[23209]: go-librespot daemon starting...
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="app state loaded"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39: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-gew1.spotify.com:80]"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-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 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-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 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=info msg="zeroconf server listening on port 40421"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="obtained new client token: AAAlhzC1OAol3b0JsOPLnfX2VcEmc6nRNtaojeBPjqLDMTunPmnSyHN3IJC9rP+5OLGvty4ek9S8K5jifuGKGA+vEtt/4jo0gnwIBi2qpUsUUNfNLFXtGFRn93vuNr6I2YO/Plod2ldg3zZ1F72zaDypvpCIYcvvX4YYjZ0lFvwBiS02St0X3fvqAfVbGibSphgfnNsGLtonZ1OvXYG8PrGosjPS8M9ZyKpobBtIj7C45Sq8i1rMHPh18g=="
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:4070, retrying with a different AP" error="dial tcp 104.154.127.247:4070: connect: connection refused"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39:16-06:00" level=debug msg="completed challenge"
Feb 25 04:39:16 volumio go-librespot[23210]: time="2026-02-25T04:39: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 25 04:39:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:17 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 04:39:17 volumio volumio[22656]: 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 25 04:39:18 volumio volumio[22656]: info: CoreCommandRouter::volumioGetState
Feb 25 04:39:18 volumio volumio[22656]: info: CorePlayQueue::getTrack 0
Feb 25 04:39:19 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:19 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Feb 25 04:39:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:19 volumio go-librespot[23217]: go-librespot daemon starting...
Feb 25 04:39:19 volumio go-librespot[23218]: time="2026-02-25T04:39:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:19 volumio go-librespot[23218]: time="2026-02-25T04:39:19-06:00" level=debug msg="app state loaded"
Feb 25 04:39:19 volumio go-librespot[23218]: time="2026-02-25T04:39:19-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:19 volumio go-librespot[23218]: time="2026-02-25T04:39:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-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 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-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 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-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 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-06:00" level=info msg="zeroconf server listening on port 33117"
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-06:00" level=debug msg="obtained new client token: AABxoqoO8JE4xFDvFVb1OUEm6Vkk16H5kOoNDI6ADs9m5tSdtTizxFdb9UcLqjsZPtaetu1ZEw1Xb+xQWST1Iqe9Uql7tANwmhf/YLerZ+D93Ui/1ENa7YMGm/bnI+xJu2OiSm6etwCcHFqfM2Q6yX35JdOfbz9ABUzHIY8/XBVg+oLI5xJwvFZYN4l/tad7B/x6QMwl/nj2VwDTlMIIA96FUfQTUkzn65p3+ASudBehL1vMan5T0CU="
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39:20-06:00" level=debug msg="completed challenge"
Feb 25 04:39:20 volumio go-librespot[23218]: time="2026-02-25T04:39: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 25 04:39:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:22 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:22 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 25 04:39:22 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 04:39:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Feb 25 04:39:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:23 volumio go-librespot[23241]: go-librespot daemon starting...
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=debug msg="app state loaded"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:23 volumio volumio[22656]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 25 04:39:23 volumio volumio[22656]: info: Completed starting MyVolumio Plugin
Feb 25 04:39:23 volumio volumio[22656]:  [Metrics]  CommandRouter:  55s 221.39ms 
Feb 25 04:39:23 volumio volumio[22656]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 25 04:39:23 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 04:39:23 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 04:39:23 volumio volumio[22656]: info: CoreCommandRouter::Close All Modals sent
Feb 25 04:39:23 volumio volumio[22656]: info: CoreCommandRouter::Close All Modals sent
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:39:23 volumio go-librespot[23242]: time="2026-02-25T04:39:23-06:00" level=info msg="zeroconf server listening on port 44217"
Feb 25 04:39:24 volumio go-librespot[23242]: time="2026-02-25T04:39:24-06:00" level=debug msg="obtained new client token: AACpGyb9IOuwRyPAp36+oeWzZ490sSxTOT/KjB3tHHoUm5ezuUK+zCO+u6RzSDeujwSWj3YvVAfZiir/WgFEFGSu2mJfGRru1E3KGqUJctIFlgl32GXdgUri92e2TjpiiWW2naJC55AY/U2vMZlpK9h+d/ajepYYArRaiK3LksKhQPH0VT0XGLh7VKRK9kklfYPi/vxWboRlziheYjygKH2LT8w0y+VEj7j9LO4LYV4t/yNJC1gnEjw="
Feb 25 04:39:24 volumio go-librespot[23242]: time="2026-02-25T04:39:24-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:24 volumio go-librespot[23242]: time="2026-02-25T04:39:24-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:24 volumio go-librespot[23242]: time="2026-02-25T04:39:24-06:00" level=debug msg="completed challenge"
Feb 25 04:39:24 volumio go-librespot[23242]: time="2026-02-25T04:39:24-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 25 04:39:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:24 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 25 04:39:24 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 25 04:39:24 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 25 04:39:25 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:25 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Feb 25 04:39:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:27 volumio go-librespot[23255]: go-librespot daemon starting...
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="app state loaded"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39: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 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39: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 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39: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 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=info msg="zeroconf server listening on port 45183"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="obtained new client token: AAC1e8j908dPki2+DQ0bp4vlI11+V59U33LqDPBlcNE/0nXmH0BMvUJG1OfG+hKhOM97o321Yjclbcs9RgMNGKYgCl0B0hLmC4xKdd+DdXhjW9hpqG/erZwX3Ibh06LNINIKmbsV+1u3EjlKw5lJoM2wzLho7Tk1ntPKTvL/dfzZcsCD2clHkIgMTWNtRbk487f7Ilza03asxmJfSr41OV5WlaT+qWxFs3AvIhss5Exa6i03TYHCxujWZA=="
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39:27-06:00" level=debug msg="completed challenge"
Feb 25 04:39:27 volumio go-librespot[23256]: time="2026-02-25T04:39: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 25 04:39:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:28 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:28 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:30 volumio volumio[22656]: info: BOOT COMPLETED
Feb 25 04:39:31 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:31 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Feb 25 04:39:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:31 volumio go-librespot[23277]: go-librespot daemon starting...
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="app state loaded"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-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 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-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 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=info msg="zeroconf server listening on port 36867"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="obtained new client token: AABTr80uD90S3EIPU3RiG4Wg29XXCpaYhvHTsPvR5dCPsBGxvR6lqStAzeJwCDM1WAKNbK9dP3wZK2CvQhacQqDGYxo/gSNSVmyesI72m0Ch4RsKGiwBnnQaJuMx/RdVBDg7BK2Op8Ldi4DZQXJt4mtQbzQLk2z7XFnJad2k02JKrREsq0ZwgrYwhhz3h7FbSVhZSXWV76lz+ykuTgS3wiw+VMRK+rlNS8nnT7rK/VoCWYQ66TzfnMT/Lg=="
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39:31-06:00" level=debug msg="completed challenge"
Feb 25 04:39:31 volumio go-librespot[23278]: time="2026-02-25T04:39: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 25 04:39:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:34 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:34 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Feb 25 04:39:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:34 volumio go-librespot[23288]: go-librespot daemon starting...
Feb 25 04:39:34 volumio go-librespot[23289]: time="2026-02-25T04:39:34-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:34 volumio go-librespot[23289]: time="2026-02-25T04:39:34-06:00" level=debug msg="app state loaded"
Feb 25 04:39:34 volumio go-librespot[23289]: time="2026-02-25T04:39:34-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:34 volumio go-librespot[23289]: time="2026-02-25T04:39:34-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-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 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-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 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-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 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-06:00" level=info msg="zeroconf server listening on port 45451"
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-06:00" level=debug msg="obtained new client token: AACI4tvkyi6rcjkCEtChaUkmuLWTMX6QouxKJ9bAIZ7xp+5olUbNkXr54S/PEi+mI2hiNyPUdZ3S7LzH+uLutbbJ1ayjI+mHO+ovVUXsrW7VuRbH2JDVerarpdHS8NqH67UkWp5Ag8QViiuL2xWeUMBFrxg6ok5XrNgn9rKFCtMst8pYd0yyDdDjphNRkohBY55dkPI9l4RflX0NTwVNpS4vGmrOLfhx4sd5ZJZoftbwAuUw7Sg2SUistg=="
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-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 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39:35-06:00" level=debug msg="completed challenge"
Feb 25 04:39:35 volumio go-librespot[23289]: time="2026-02-25T04:39: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 25 04:39:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:37 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:37 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Feb 25 04:39:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:38 volumio go-librespot[23296]: go-librespot daemon starting...
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=debug msg="app state loaded"
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-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 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-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 25 04:39:38 volumio go-librespot[23297]: time="2026-02-25T04:39:38-06:00" level=info msg="zeroconf server listening on port 45211"
Feb 25 04:39:39 volumio go-librespot[23297]: time="2026-02-25T04:39:39-06:00" level=debug msg="obtained new client token: AAAaHNJZdoygqHT5DGzRcWTAs1xw9ZxGUfYbo2h2J83XVsn9Rwb9GGp7mLoteu4/G2a+PbMwG8LVMW1pa3iSFJoBXBxEF3vTk/HLp6CZXiXTyGmroF9lI6AOgflbOszLEcYkSfLsT+hoywQnX8LbEmbWg19DskPEdqad/5t8EETPtS7had1msQ31alaCWqeb+iXP6lKg4sin0GumU8WEs5IJ+uz9hJLPgC3vdsLVHb0ypA/cAx7HPx0="
Feb 25 04:39:39 volumio go-librespot[23297]: time="2026-02-25T04:39:39-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:39 volumio go-librespot[23297]: time="2026-02-25T04:39:39-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:39 volumio go-librespot[23297]: time="2026-02-25T04:39:39-06:00" level=debug msg="completed challenge"
Feb 25 04:39:39 volumio go-librespot[23297]: time="2026-02-25T04:39: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 25 04:39:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:40 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:40 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Feb 25 04:39:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:42 volumio go-librespot[23319]: go-librespot daemon starting...
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="app state loaded"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-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 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-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 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=info msg="zeroconf server listening on port 36201"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="obtained new client token: AAADi4wFnGAmXwfKpZ6sqiKIzACVH3dD7c2l0UZhXZXJJ2L0yCboEDBPuORsV0L9e26oLfhoHG1+i6v747jQCVV45AXhnkKZMBJw8LrlGi90tupT/toy9f9C/FFF9sT9/dYGKrQk+mpHnn4RFA6yesryWLRUfmII4lzie6Rz5HV6FmdP9GqHG4jmvCt4WIRCp02LwLMzFTgnSHJVxOVDHYc1D4j+L+XidI7E1jEEDpMPh+fVo84U41zZQg=="
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39:42-06:00" level=debug msg="completed challenge"
Feb 25 04:39:42 volumio go-librespot[23320]: time="2026-02-25T04:39: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 25 04:39:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:43 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:43 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:45 volumio volumio[22656]: info: UPDATER: Scheduling automatic update
Feb 25 04:39:45 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Feb 25 04:39:45 volumio volumio[22656]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Feb 25 04:39:45 volumio volumio[22656]: info: UPDATER: Auto update will take place at: Thu Feb 26 2026 05:49:58 GMT-0600 (Central Standard Time)
Feb 25 04:39:46 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:46 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Feb 25 04:39:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:46 volumio go-librespot[23327]: go-librespot daemon starting...
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="app state loaded"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-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 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-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 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=info msg="zeroconf server listening on port 36015"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="obtained new client token: AADMInMxkypdXP5A7SdAXs+vbxN6n30Foh5fkfcgehotc8eoqy7UHjIqwiuEDLtKYpTsEy7vlmPG4Ae+iXf4nMzpQFT4DpSFQYKQmABlkS8vIkpTh8XthXnwA30G/dAlYTJs+Mkrh4kEMkv0OAjpcozKggJtp4Y+wyRz0erG+Goxun2Jcsql33biHMztZcjy3K30yZbunGTRYl6qu9FGQVfpI72UsKxzpILKmEV1wM3CG7Z+P+XfhPoTWg=="
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39:46-06:00" level=debug msg="completed challenge"
Feb 25 04:39:46 volumio go-librespot[23328]: time="2026-02-25T04:39: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 25 04:39:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:49 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:49 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Feb 25 04:39:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:49 volumio go-librespot[23335]: go-librespot daemon starting...
Feb 25 04:39:49 volumio go-librespot[23336]: time="2026-02-25T04:39:49-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:49 volumio go-librespot[23336]: time="2026-02-25T04:39:49-06:00" level=debug msg="app state loaded"
Feb 25 04:39:49 volumio go-librespot[23336]: time="2026-02-25T04:39:49-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:49 volumio go-librespot[23336]: time="2026-02-25T04:39:49-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-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 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-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 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-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 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-06:00" level=info msg="zeroconf server listening on port 37729"
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-06:00" level=debug msg="obtained new client token: AACdQb7xb7SFkM040mUrQxncL5Whl+XaK7Kj/KOHEBLGDPn21c0qyqHpJUHj0SWKOx92rjHl/6/4hPyJucCxzzjfPQHyQmnhId890uAhG4k7wX3Qxw82GywvMNaAU/UcAeg1AlQneEMOi51whrz50BpmrUMIYqDzeDPmSw3WSbbmBSNtnNCoKCZTczR93x0AXct8OKWPDhCeKZ2As5leCaDBuX+xQCVKEJoMPsJu5kB0X1JlLSVwLAc="
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39:50-06:00" level=debug msg="completed challenge"
Feb 25 04:39:50 volumio go-librespot[23336]: time="2026-02-25T04:39: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 25 04:39:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:52 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:52 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37.
Feb 25 04:39:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:53 volumio go-librespot[23357]: go-librespot daemon starting...
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-06:00" level=debug msg="app state loaded"
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-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 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-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 25 04:39:53 volumio go-librespot[23358]: time="2026-02-25T04:39:53-06:00" level=info msg="zeroconf server listening on port 37919"
Feb 25 04:39:54 volumio go-librespot[23358]: time="2026-02-25T04:39:54-06:00" level=debug msg="obtained new client token: AAAAshrqmMN3MXGEa2a3p2VU5rZqujdRcli0gjJyThfr7c+iDyiWf/O9X3YJjjjrMieKs9NTqEH/My5QLkE8UAKmzOhOhZrgQ50PVGOzgrgZjr0pJi1MnLAyYXgJyla11Xg7MRvOyIBIjJVx1E6ipkZiL/ocg2A30KGNtFWcr+WlKwWunPHTa3OcdAZGhLWlWA5YSTTIB5ArxUETZQra7zTNGhPiLFAZC6PzvWtbraJrlrrB8YoBL1Y="
Feb 25 04:39:54 volumio go-librespot[23358]: time="2026-02-25T04:39:54-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:54 volumio go-librespot[23358]: time="2026-02-25T04:39:54-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:54 volumio go-librespot[23358]: time="2026-02-25T04:39:54-06:00" level=debug msg="completed challenge"
Feb 25 04:39:54 volumio go-librespot[23358]: time="2026-02-25T04:39:54-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 25 04:39:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:55 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:55 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:39:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38.
Feb 25 04:39:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:39:57 volumio go-librespot[23368]: go-librespot daemon starting...
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="app state loaded"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="stored credentials not found"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39: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 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39: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 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39: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 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=info msg="zeroconf server listening on port 36293"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="obtained new client token: AAA/AAT+TxBIyNRF2s+FnjZxg9jQEQRMD4FiG5oLie8/QYizYNatv+odIEocKsbHdwIo2vOHQZBjALCh7XBA8Xr1vhLfz9ps+sarK+CT/c1/gL3nWiF4L0oLF5i4WhNivHawYyYmbsGbOQxjJLibhx5WsVG5QjE6qjjkk9o7GmV1aMARE3CBvXd2USpdn1cYCsJmxTWQRBpwLtmNY8rkB1Mc8f2npM7P9JuoFM6bpgCIt0elLSU90Mo3Ug=="
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="completed keyexchange"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39:57-06:00" level=debug msg="completed challenge"
Feb 25 04:39:57 volumio go-librespot[23369]: time="2026-02-25T04:39: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 25 04:39:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:39:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:39:58 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:39:58 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39.
Feb 25 04:40:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:01 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:01 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:01 volumio go-librespot[23390]: go-librespot daemon starting...
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="app state loaded"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40: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 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40: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 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40: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 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=info msg="zeroconf server listening on port 42395"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="obtained new client token: AADL0wU3zIFtKPgVIoi3GYQX8694ogyCJjM4rbYrR+DZAUNAyG0c/5u6xUTfiytKBv909ygSxft80XyJLURgbflUeFeskWjGE/yuA/O8wMMh6S/ewQQXzay1+liM1nhXR6MgPi2xWzBVLGGfZs55gKq+3vCMQiM6E43YPqVVc0OO7mqPeHAHlVfySIvapbdD/Zi+m/EKg0P0fKfVu0yqX6VDsD61ooP7AWUYk5zZfk1D0pdFotP7dhMBfg=="
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40:01-06:00" level=debug msg="completed challenge"
Feb 25 04:40:01 volumio go-librespot[23391]: time="2026-02-25T04:40: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 25 04:40:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:04 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:04 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40.
Feb 25 04:40:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:04 volumio go-librespot[23399]: go-librespot daemon starting...
Feb 25 04:40:04 volumio go-librespot[23400]: time="2026-02-25T04:40:04-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:04 volumio go-librespot[23400]: time="2026-02-25T04:40:04-06:00" level=debug msg="app state loaded"
Feb 25 04:40:04 volumio go-librespot[23400]: time="2026-02-25T04:40:04-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:04 volumio go-librespot[23400]: time="2026-02-25T04:40:04-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=info msg="zeroconf server listening on port 35313"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="obtained new client token: AADZ2TgI/7UvuL9GPfuDscGJuzLN1b+Rt/egHG469+T1LFTdibZH5Pk42XWiZmf4SxhzXpdT6kKde6RzdkezVsPMy+bO5rTTQc0kVJwgZVX4mU0dBIb2Qkp4/fQzMZQMaowob0pXC7LW399ScQHyxWRPM3fLB6PYrYiQEsimyQsasHKgIFNnJZhqgkip9sFQnuEQvQ/2fcA0CmTgUOCs5WqeqlNfMhZGUCvYO3sZVMs70bUA1dGSz2g="
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40:05-06:00" level=debug msg="completed challenge"
Feb 25 04:40:05 volumio go-librespot[23400]: time="2026-02-25T04:40: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 25 04:40:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:07 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:07 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41.
Feb 25 04:40:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:08 volumio go-librespot[23407]: go-librespot daemon starting...
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=debug msg="app state loaded"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:08 volumio go-librespot[23408]: time="2026-02-25T04:40:08-06:00" level=info msg="zeroconf server listening on port 43173"
Feb 25 04:40:09 volumio go-librespot[23408]: time="2026-02-25T04:40:09-06:00" level=debug msg="obtained new client token: AAA6D7J/ukEnKfFsb5us53/xxAEOY/PuuuVRy/nCnBJjCgBJoJJAohDJ3/biBwIky82qXk2AwcI8ZGDYi9fT/wiUxxNmoajMWvxwKl9xksLXOHR27K/WVJIyIh4gg/zxIxY+v/sJF+xSrTdeNODJ65cYigSnLASlcA12gI+V1OR4zypAM0wHBHbhWvWdU7WitV5g1pewy78jAzmrU5sqZWc9cSzNiaQ0IbwXiyhdtM4CoPEP1MvcKF4="
Feb 25 04:40:09 volumio go-librespot[23408]: time="2026-02-25T04:40:09-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:09 volumio go-librespot[23408]: time="2026-02-25T04:40:09-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:09 volumio go-librespot[23408]: time="2026-02-25T04:40:09-06:00" level=debug msg="completed challenge"
Feb 25 04:40:09 volumio go-librespot[23408]: time="2026-02-25T04:40:09-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 25 04:40:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:10 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:10 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42.
Feb 25 04:40:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:12 volumio go-librespot[23429]: go-librespot daemon starting...
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="app state loaded"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-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 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-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 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=info msg="zeroconf server listening on port 43249"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="obtained new client token: AAAeIiEfNDbLInvg9Z6CLAl+JAvlkXOd2qB8A2KuRjQDkDAMEWqTGCrs1er7+qotnOkjnaSIGa+X1U/MdJdbzJEAdXrnv9qLFSjhkMsN+zQEXiT2Z1CEewaA7oxSbo+qn6lipr6ojSGmVX8+HAAw7B0IW2j9ZSpqHM9nTzeGEdjauh0tEd0uFBmRfN357L3LK6IWdoh9oirwidEsj4f6dMTUzQPfxXykWaTN7TZe8n8na+tR/2NmiKiMmA=="
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40:12-06:00" level=debug msg="completed challenge"
Feb 25 04:40:12 volumio go-librespot[23430]: time="2026-02-25T04:40: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 25 04:40:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:13 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:13 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43.
Feb 25 04:40:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:16 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:16 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:16 volumio go-librespot[23440]: go-librespot daemon starting...
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="app state loaded"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40: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 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40: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 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40: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 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=info msg="zeroconf server listening on port 37229"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="obtained new client token: AACvM1LRzkR/w0ca/msUZ+g0k4lHHam9DxYqM9WRLyQ85UpVCVQN43v6fiIAQfJqWmwTBHgWa4Tnqu3NfU+2ETuDj8igl9kFPyc1BrLrCrlvAlY/0C05B8MRPLlEwRCd2smmpUmw9veofqwSQNa4zLHnt9QYPg5uJBFqk5NtSwNbP2vFE2VT4N4MRHbaG8CnIFjo7j3Rx2O4M0FJOzciRPFl3taSZ971UN4q7xsmN/yQaemycyuYB3/qKA=="
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40:16-06:00" level=debug msg="completed challenge"
Feb 25 04:40:16 volumio go-librespot[23441]: time="2026-02-25T04:40: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 25 04:40:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:19 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:19 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 44.
Feb 25 04:40:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:19 volumio go-librespot[23448]: go-librespot daemon starting...
Feb 25 04:40:19 volumio go-librespot[23449]: time="2026-02-25T04:40:19-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:19 volumio go-librespot[23449]: time="2026-02-25T04:40:19-06:00" level=debug msg="app state loaded"
Feb 25 04:40:19 volumio go-librespot[23449]: time="2026-02-25T04:40:19-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:19 volumio go-librespot[23449]: time="2026-02-25T04:40:19-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-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 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-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 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-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 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-06:00" level=info msg="zeroconf server listening on port 36913"
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-06:00" level=debug msg="obtained new client token: AADuK9edXyj8PmbjbGghqVlp9+yN26DFwh0COIeOXyX9DPxnKAj5tVAlq01Ln3Xk4rfxrv+SdSjs4BdQdKtqK0Mrcu+6ij2guZeqbyiYdO+InBTqJQukVWtOC++o+8EKDVia9Edf6ssx03G1J5SXf6SHZ5XR9RCr2XBH7CDyGk05VIyJDJ9hgrAxIMWqB89inFuL4yvNET6bC+UMNJxdPjFCE0oQ+skyFtCWgGw3qGdLlW8r7wCUCCqzCQ=="
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40:20-06:00" level=debug msg="completed challenge"
Feb 25 04:40:20 volumio go-librespot[23449]: time="2026-02-25T04:40: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 25 04:40:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:22 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:22 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 45.
Feb 25 04:40:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:23 volumio go-librespot[23471]: go-librespot daemon starting...
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=debug msg="app state loaded"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:23 volumio go-librespot[23472]: time="2026-02-25T04:40:23-06:00" level=info msg="zeroconf server listening on port 32979"
Feb 25 04:40:24 volumio go-librespot[23472]: time="2026-02-25T04:40:24-06:00" level=debug msg="obtained new client token: AACi1z+n+Iia1mpXMWStbJDNLZct0hMoIx0w2lhP7XZI8KQ0k/p07/monEXTOIMPU4GScPPB/W02Htsa9HAgXrnNJW4bRxFugM61771a0SDI1Gdv5QUeCeAsir8p7ssyemZGD37plzkCpQFM/UcVDDYNY3ldYA6w8kNhCHitV4M2dVRBK+CeMdMe2uUuQvtVyrEpIH/s7XP5hN+xoTIAcsFxlh8NULjez/oqbO7s7C+QrHUvGaAEqMA="
Feb 25 04:40:24 volumio go-librespot[23472]: time="2026-02-25T04:40:24-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:24 volumio go-librespot[23472]: time="2026-02-25T04:40:24-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:24 volumio go-librespot[23472]: time="2026-02-25T04:40:24-06:00" level=debug msg="completed challenge"
Feb 25 04:40:24 volumio go-librespot[23472]: time="2026-02-25T04:40:24-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 25 04:40:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:25 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:25 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 46.
Feb 25 04:40:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:27 volumio go-librespot[23479]: go-librespot daemon starting...
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="app state loaded"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=info msg="zeroconf server listening on port 40881"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="obtained new client token: AADqHlkDHNZJkHMsDkpCmTGv5ngz6WLt6AKTZfqUrYFJTOSoMBWN5/RMbSIWiYIhjlqkgRsJHTxO6zWt5wmeMT0N8deLx8F7+ZfRlm7oUyCxU53aJKfxTMyqtwRE+2npXjZ+4DYYTsFZa9rpW9p3QR3/6jaPNHrrr1dujlBI7Hq1IR7hSNKzr0opWRhsESbNUrz9dsSKf12cjazDKSUdWvmIeckVwYbqmXdN9ERcq7VAbGFCQQPc40soAg=="
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40:27-06:00" level=debug msg="completed challenge"
Feb 25 04:40:27 volumio go-librespot[23480]: time="2026-02-25T04:40: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 25 04:40:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:28 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:28 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 47.
Feb 25 04:40:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:31 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:31 volumio go-librespot[23487]: go-librespot daemon starting...
Feb 25 04:40:31 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="app state loaded"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-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 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-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 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=info msg="zeroconf server listening on port 39211"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="obtained new client token: AAAljlJgT3S/gsYp7e7H0RgdYvEqdu0zBu8sUXhtAFYv8Pnaxe0JD3CcnwoirpUI3r7sXETEtGzDGG5vt2uvwUGomuKgufaUtUp1oFF3NAwFqlUZq+gxfqOxKPg4cOu6H0d7EzsTX38RsWjBSvgIrJfv3FVmGo4xLu5ezQmvBK03r9Pc9GSZ4vhGLk2JkhqX4o9mSAN9Om9Y9ioFmJ8HQ7IvYZ+aGBcsnN6V/seaE7Mgh35d3vU3WguYkw=="
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-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 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40:31-06:00" level=debug msg="completed challenge"
Feb 25 04:40:31 volumio go-librespot[23502]: time="2026-02-25T04:40: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 25 04:40:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:34 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:34 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 48.
Feb 25 04:40:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:34 volumio go-librespot[23512]: go-librespot daemon starting...
Feb 25 04:40:34 volumio go-librespot[23513]: time="2026-02-25T04:40:34-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:34 volumio go-librespot[23513]: time="2026-02-25T04:40:34-06:00" level=debug msg="app state loaded"
Feb 25 04:40:34 volumio go-librespot[23513]: time="2026-02-25T04:40:34-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:34 volumio go-librespot[23513]: time="2026-02-25T04:40:34-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-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 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-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 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-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 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-06:00" level=info msg="zeroconf server listening on port 40529"
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-06:00" level=debug msg="obtained new client token: AAC8vLxXbXv3oscwG65nxa3KBCjGTw8x2ESPrKP48baInIOAPC/vjl3HM7Q75jYeXSlzgnp7E271i/KuujxQGUB9DqV0Tl0rzOqxVSrUHKYK4clnk+jcjlgUiGm61RkH2MO7NEReCK9T9u8s3kvih4N9PfBKBckolcuUjDGqaPrjaqdy8riXg1eet8h6zzPBvkbkrdRNm4jB2n/pXlZrzu8R47kAWVaOCCr49pdHgDJDrMad8uhY6DA="
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40:35-06:00" level=debug msg="completed challenge"
Feb 25 04:40:35 volumio go-librespot[23513]: time="2026-02-25T04:40: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 25 04:40:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:37 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:37 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 49.
Feb 25 04:40:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:38 volumio go-librespot[23520]: go-librespot daemon starting...
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=debug msg="app state loaded"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:38 volumio go-librespot[23521]: time="2026-02-25T04:40:38-06:00" level=info msg="zeroconf server listening on port 45719"
Feb 25 04:40:39 volumio go-librespot[23521]: time="2026-02-25T04:40:39-06:00" level=debug msg="obtained new client token: AABU5d7psB4LuWeyMefWeXV385Mze0ytPRr04gocGZIA/DDw0++jn0RjE5e8q7HA6TD9VHC+gqemSFLxC3dFqpmATchRJtbgf6AAQcZxRWpCN1IIDLiKleOIOxw02Z/7cUqXwW6MWLCVsmBuQfQMz7fgPQTBJ2YQZ3u+sog0DCUDwju6S0LGiVrwCtFpgy8Sagb3G1gze8h1ZzgMTl73PhA/x05yt3YAv5SgNhcmhIx4zK68QfARkZE="
Feb 25 04:40:39 volumio go-librespot[23521]: time="2026-02-25T04:40:39-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:39 volumio go-librespot[23521]: time="2026-02-25T04:40:39-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:39 volumio go-librespot[23521]: time="2026-02-25T04:40:39-06:00" level=debug msg="completed challenge"
Feb 25 04:40:39 volumio go-librespot[23521]: time="2026-02-25T04:40: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 25 04:40:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:40 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:40 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 50.
Feb 25 04:40:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:42 volumio go-librespot[23543]: go-librespot daemon starting...
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="app state loaded"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=info msg="zeroconf server listening on port 46103"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="obtained new client token: AABAQUi9Ytb/nfnRiEP5ia7X8mJlIbByfiQeKLoG7Tsy0USdNgamHYTBi/0H7pRzMk/s6DXOBOxWLpQfVPVUCulpSNU1Hn3PEA3+QNWj2WE3AbIvARFqc2vwjFpkxyV5gIXuPVVLqj71KudPxGD7sFhr/qpnoVw+rSz8j0CNT+TrxlMIm08MoWGJKNNfHY0dB4D1J+ctMVp8UAHgArT1XyglL1TACdOknAL6o3cnJ6NyWyyp/BEY+hojAQ=="
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40:42-06:00" level=debug msg="completed challenge"
Feb 25 04:40:42 volumio go-librespot[23544]: time="2026-02-25T04:40: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 25 04:40:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:43 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:43 volumio volumio[22656]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51.
Feb 25 04:40:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:46 volumio go-librespot[23551]: go-librespot daemon starting...
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="app state loaded"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:46 volumio volumio[22656]: info: Initializing connection to go-librespot Websocket
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="new websocket client"
Feb 25 04:40:46 volumio volumio[22656]: info: Connection to go-librespot Websocket established
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-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 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-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 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=info msg="zeroconf server listening on port 35537"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="obtained new client token: AADY7cWotdGUWdyErPa814Suw6CxPPBPSpJfWmsirpf2vVgcU+3DQpHKjMERnBJ6PhZKHsCjdemRAUA1RDdppt/VvDy4evG5nCxBDkN261NPNLVWhpOSWPH7IOFqTc9+9AEyYCsofeP5QeTSL7FJ1T6gGR2ijIqsdZFBRnQbD9TibXmDp3M/QBbp1IHlpi06MOKvG3Oa30Rf3b0dfFbOF73mmsFUBdfzbQv97YoKu2iEf9yoknmjPJpSIQ=="
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="completed keyexchange"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40:46-06:00" level=debug msg="completed challenge"
Feb 25 04:40:46 volumio go-librespot[23552]: time="2026-02-25T04:40: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 25 04:40:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 04:40:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 04:40:46 volumio volumio[22656]: info: Connection to go-librespot Websocket closed
Feb 25 04:40:49 volumio volumio[22656]: info: Getting Spotify volume
Feb 25 04:40:49 volumio volumio[22656]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 04:40:49 volumio volumio[22656]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 04:40:49 volumio volumio[22656]:     at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 25 04:40:49 volumio volumio[22656]:   errno: -111,
Feb 25 04:40:49 volumio volumio[22656]:   code: 'ECONNREFUSED',
Feb 25 04:40:49 volumio volumio[22656]:   syscall: 'connect',
Feb 25 04:40:49 volumio volumio[22656]:   address: '127.0.0.1',
Feb 25 04:40:49 volumio volumio[22656]:   port: 9879,
Feb 25 04:40:49 volumio volumio[22656]:   response: undefined
Feb 25 04:40:49 volumio volumio[22656]: }
Feb 25 04:40:49 volumio volumio[22656]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 04:40:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52.
Feb 25 04:40:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 04:40:49 volumio go-librespot[23571]: go-librespot daemon starting...
Feb 25 04:40:50 volumio go-librespot[23572]: time="2026-02-25T04:40:50-06:00" level=info msg="running go-librespot 0.4.0"
Feb 25 04:40:50 volumio go-librespot[23572]: time="2026-02-25T04:40:50-06:00" level=debug msg="app state loaded"
Feb 25 04:40:50 volumio go-librespot[23572]: time="2026-02-25T04:40:50-06:00" level=debug msg="stored credentials not found"
Feb 25 04:40:50 volumio go-librespot[23572]: time="2026-02-25T04:40:50-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 04:40:50 volumio sudo[23581]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 04:39'
Feb 25 04:40:50 volumio sudo[23581]: 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"