Feb 11 03:04:01 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:01 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Feb 11 03:04:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:02 volumio go-librespot[25705]: go-librespot daemon starting...
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="app state loaded"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-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 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-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 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=info msg="zeroconf server listening on port 38441"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="obtained new client token: AACzchVoWNUyC8yptr/INBafIx5IFCQdA1JxsxghkFUxtGVxKbN4/UhQRf8LjTAV4UepdHSDc9IPEMRBrrby209LK3eCy6PNM+vvB6ML+yNdE2p43f8Tm9G6C15exXCb7GYSPb7SlSMqAiSQpzdpijv67VDyxhex5GAs8kC02EdAgxj0Ku8Uc7rHQ4LDwmFXWahCs1kmYf0ks4eB4uWyayGSNRRyaR0x5NQZxNRLs0sCE/KW755vCXxogw=="
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=debug msg="completed challenge"
Feb 11 03:04:02 volumio go-librespot[25706]: time="2026-02-11T03:04:02-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:04 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:04 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25.
Feb 11 03:04:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:05 volumio go-librespot[25713]: go-librespot daemon starting...
Feb 11 03:04:05 volumio go-librespot[25714]: time="2026-02-11T03:04:05-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:05 volumio go-librespot[25714]: time="2026-02-11T03:04:05-06:00" level=debug msg="app state loaded"
Feb 11 03:04:05 volumio go-librespot[25714]: time="2026-02-11T03:04:05-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:05 volumio go-librespot[25714]: time="2026-02-11T03:04:05-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=info msg="zeroconf server listening on port 33289"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="obtained new client token: AACm3v7BXNxU+NEWrWvklpc6XhbjBZKlLg/CqGmvxjIae3dSFhDXyC2334AAKXb9tlAKm7S9rjssykGLuh/MOdib5ZpaSpJ7R4+D+RZuoOFPPa8pXead0FgwJ3I4O0qIXVe0CBKiaTUNl0Pu4ifWa4f4oROMMQmoGqCIDKSSwxj/5WqDjgWpUnY1uRXm44MsXx1xB2ztBxbFF5gNeQdXTlQwtTzT40PoPnoZA/p43j05bDJnCfXyn08="
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=debug msg="completed challenge"
Feb 11 03:04:06 volumio go-librespot[25714]: time="2026-02-11T03:04:06-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:07 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:07 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Feb 11 03:04:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:09 volumio go-librespot[25721]: go-librespot daemon starting...
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=debug msg="app state loaded"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-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 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-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 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=info msg="zeroconf server listening on port 44717"
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=debug msg="obtained new client token: AACcCR1qhHVij6Iwf346ayPolx1d7FkhJREj43s0QgIHanIq0EfY728V3uYXlnFcMlVSE/RBP0dwoDx4i1NUsK+SCfn37qll7MDKD4j2KMdtoWPohwcyEzQzCWJJbun4gtCuOaP/5+DRVk546NmLBfDmzGvA53tcmEcdscNcAM0kExGhOWGLORTFORhaMoE7Yxv9d57JwAHHKs3uxlKKCItiaRv8j+FGaQQ63xl0Su12k2PxaXbxDXVntw=="
Feb 11 03:04:09 volumio go-librespot[25722]: time="2026-02-11T03:04:09-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:10 volumio go-librespot[25722]: time="2026-02-11T03:04:10-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:10 volumio go-librespot[25722]: time="2026-02-11T03:04:10-06:00" level=debug msg="completed challenge"
Feb 11 03:04:10 volumio go-librespot[25722]: time="2026-02-11T03:04:10-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:10 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:10 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:13 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:13 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Feb 11 03:04:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:13 volumio go-librespot[25744]: go-librespot daemon starting...
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="app state loaded"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=info msg="zeroconf server listening on port 42107"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="obtained new client token: AABao7slaX4L4Lx8amSOAqChvvujkvS1h83mCU+a2rsLVoQTV4T3ZbKIF2CQy1UMJorVnPvoZwAzZISCfFW0eqBcsXCqwt8chnc2MH8LxzGmVnVd9+dwZz2F2AzwnxL/BpLeiAgPSx0jDJWSbuoPAP2C0kgPcZNIIxLcO2zqkKHmqTclB+VmdWw5JF9UpN0RWgL8a6d1+40H5LsrqWBcTTl55CFAAzu0/y5lqDf2sqhbMDhwGukPKHKRhg=="
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-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 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=debug msg="completed challenge"
Feb 11 03:04:13 volumio go-librespot[25745]: time="2026-02-11T03:04:13-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:16 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:16 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Feb 11 03:04:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:17 volumio go-librespot[25752]: go-librespot daemon starting...
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="app state loaded"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=info msg="zeroconf server listening on port 39287"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="obtained new client token: AABMsQYLr284qiXKq+Zt3x66/PL7538a0wl4jK89L3NwK+Vq7vVBkTr15cZBDujQlA+Ly5KCxCDiY+pf2EaFEQLJDYF8DllQURe46GpokPTKy4GlbInFZy211k6rDj2MVzM6HVWXrAkEKoY2+2T+fXHgV2VUcRCLnAtLy989QuEj+L8pHzORQOQHu11J1XlA5G/ED2fOwTNO024u8lhOZyh1BuSMj6kb8kDeWoTAQ7ts4mClyq/jz0rY1g=="
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-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 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=debug msg="completed challenge"
Feb 11 03:04:17 volumio go-librespot[25753]: time="2026-02-11T03:04:17-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:19 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:19 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Feb 11 03:04:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:20 volumio go-librespot[25778]: go-librespot daemon starting...
Feb 11 03:04:20 volumio go-librespot[25779]: time="2026-02-11T03:04:20-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:20 volumio go-librespot[25779]: time="2026-02-11T03:04:20-06:00" level=debug msg="app state loaded"
Feb 11 03:04:20 volumio go-librespot[25779]: time="2026-02-11T03:04:20-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:20 volumio go-librespot[25779]: time="2026-02-11T03:04:20-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=info msg="zeroconf server listening on port 34421"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="obtained new client token: AAAoYH7QNphW16K1FzNzjTIesujj6J5mgABaxaDRzRV3XoAWt+o8lWpTcP7CuWc5PKxHt+tfrubfU3sMtINHHwcGajKJRTkVuCzQ6JXlhy/ysJDX7Cz9W1+ZEydaIOywCO19wgeLUnqojHHvXlrsq778t4DT5omKRn/CDjl3EKmF18gesLzPLwD7SLdjN368PPFKT4VjcaPkwu3RVEeu3cdf4CjY+C/MTw5+omdlezW9qiAhw3EJB1g="
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=debug msg="completed challenge"
Feb 11 03:04:21 volumio go-librespot[25779]: time="2026-02-11T03:04:21-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:22 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:22 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Feb 11 03:04:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:24 volumio go-librespot[25786]: go-librespot daemon starting...
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="app state loaded"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=info msg="zeroconf server listening on port 40575"
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-06:00" level=debug msg="obtained new client token: AABSbLi6GwCdy1XxxgWRhOEi2jgqVRHN0AzftCesFkBDLCp9luBvBonSyQ1imICpgrI6B3ccK1KfoNS0MymIfusBpx22wtSeP430V6lQ52BmNXUs3i2IylvYWRVIFJFYD1Zya/Cpah2HMq8xg/Ytn/lXtNmmdi4Qxq4Y7H/IfUINlfr/9NlqEvTujoT3KoWE5upDMT6PtIqVe840v48HrvK7WTyBWfgON+2qsiblMGKlxPld+wt54dENsQ=="
Feb 11 03:04:24 volumio go-librespot[25787]: time="2026-02-11T03:04:24-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 11 03:04:25 volumio go-librespot[25787]: time="2026-02-11T03:04:25-06:00" level=debug msg="connected to ap-guc3.spotify.com:443"
Feb 11 03:04:25 volumio go-librespot[25787]: time="2026-02-11T03:04:25-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:25 volumio go-librespot[25787]: time="2026-02-11T03:04:25-06:00" level=debug msg="completed challenge"
Feb 11 03:04:25 volumio go-librespot[25787]: time="2026-02-11T03:04:25-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:25 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:25 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Feb 11 03:04:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:28 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:28 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:28 volumio go-librespot[25794]: go-librespot daemon starting...
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="app state loaded"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-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 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-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 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=info msg="zeroconf server listening on port 42689"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="obtained new client token: AADbV+m9rXW7hl9Q8kY+yCj0LswO5CDjLfykpkL3qE4pYnfG5ENUzTBXKfw3Vj3vxu1pSZG/Nnm0Sosue14G3v4Z3WeXBtmDwN72E+b75xLDG2Ix4+KR8znDvYQT/XLTAx7Q2HfronufnproFSNNEI5/uMKIJpAcIKKiYPk4x7bJcfyQrt3aO9yfO/8k1QNwosmwWvBB5O13OGR4d9pH3r2biRZTYMErnPWlNlNmJGGCwdSRtT4ICAcZGQ=="
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=debug msg="completed challenge"
Feb 11 03:04:28 volumio go-librespot[25795]: time="2026-02-11T03:04:28-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:31 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:31 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Feb 11 03:04:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:32 volumio go-librespot[25816]: go-librespot daemon starting...
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="app state loaded"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-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 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-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 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=info msg="zeroconf server listening on port 35485"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="obtained new client token: AAC0jeEG14CfFbbilYaz6/SyXRB4pD1iGGCeYv312V/wDonnxuz/e02GC4A9KwKpQ/BIgZX9gFBBCh2mX+7dW4opf/o/D/nF7y3khOzG3tGZBSH3YFsQOKw3flA87FG1VSZ/P3oB6QXybMMPZWpJv9dvhFTrKA63Bd8KJw+dSBhVeD6zZaC8159mTc0cHIEzdNtoHpWJ3koP9Sn8wbGAxpQNcgaO4dF1ZnPuDHzdBc9UA1OAkyCSrmuGEA=="
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=debug msg="completed challenge"
Feb 11 03:04:32 volumio go-librespot[25817]: time="2026-02-11T03:04:32-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:34 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:34 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Feb 11 03:04:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:35 volumio go-librespot[25824]: go-librespot daemon starting...
Feb 11 03:04:35 volumio go-librespot[25825]: time="2026-02-11T03:04:35-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:35 volumio go-librespot[25825]: time="2026-02-11T03:04:35-06:00" level=debug msg="app state loaded"
Feb 11 03:04:35 volumio go-librespot[25825]: time="2026-02-11T03:04:35-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:35 volumio go-librespot[25825]: time="2026-02-11T03:04:35-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-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 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-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 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=info msg="zeroconf server listening on port 44413"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=debug msg="obtained new client token: AADI8ebHeFozo89Z99mFYFMVe4voVUtuW/JDrEhXQryGRdK/WlrGaw0IZwrnP+HS7jhb97iURtgjc9tKqzxvnx8PX1BtFgGZTjJTfECH8sLKt103cB54h2JHojQEvbjdzjxIjM4GWIdLu+DEvq9aBKhnH4LIpBEEmK8zWAlXWsbCMrU4bX2S04mKvUeOrnS4IBBVlWzU+CmO/tRYT09/F0Pc6v2hQC5uTdMZo0FRNBf6XIch+/3GIk0="
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=debug msg="completed challenge"
Feb 11 03:04:36 volumio go-librespot[25825]: time="2026-02-11T03:04:36-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:37 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:37 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Feb 11 03:04:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:39 volumio go-librespot[25836]: go-librespot daemon starting...
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=debug msg="app state loaded"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-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 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-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 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=info msg="zeroconf server listening on port 32823"
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=debug msg="obtained new client token: AAAVyL3hoglsPyfuX5TiQ1f6fWEGLCikBUcwrE0kQnfgb+2E9KbKk+roeyj6IH/Xmchuq33x17SOiggmdkZMifRpHSnExenu5WL1UV6maTbrhd+62ybI9agMbrZn5amaPNYj//RMvvGbH9ruk/ILFc1vxQBAPJhcmh9JQ70JsxsdaSDL+04WhQqz+wro8vuMr8d0CvAtz+0S53tRNlhJ3Vr6KqcfS0O/Ylx0n5sNT11EDFzVeCcLsVXhHw=="
Feb 11 03:04:39 volumio go-librespot[25837]: time="2026-02-11T03:04:39-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:40 volumio go-librespot[25837]: time="2026-02-11T03:04:40-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:40 volumio go-librespot[25837]: time="2026-02-11T03:04:40-06:00" level=debug msg="completed challenge"
Feb 11 03:04:40 volumio go-librespot[25837]: time="2026-02-11T03:04:40-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:40 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:40 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Feb 11 03:04:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:43 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:43 volumio go-librespot[25858]: go-librespot daemon starting...
Feb 11 03:04:43 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="app state loaded"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-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 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-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 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=info msg="zeroconf server listening on port 37701"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="obtained new client token: AACLV4lnO7i3b9Fve2d1XiCwTqFfvXBGtvSNJ6OXD1HFwUYPlYCHW5StV/dHWja0DxcrrkN+mLGsQalKACSWQBE6N2jPDEXqDH7/pSVGl2zHmdf7lC/6TUq0HmxXcB3YJEQ+7+akWvd/098hVce39Dj6LlBqqEX4D6apeyFd6xDTpstF4MXvwxh+A3sukbvCaNIL1L5dzsgOglnTsZkVCMa2Mkbj2zTzjuN3Pzs90PYaoOByO66Pr9vwZw=="
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=debug msg="completed challenge"
Feb 11 03:04:43 volumio go-librespot[25859]: time="2026-02-11T03:04:43-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:46 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:46 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Feb 11 03:04:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:47 volumio go-librespot[25866]: go-librespot daemon starting...
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="app state loaded"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-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 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-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 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=info msg="zeroconf server listening on port 36857"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="obtained new client token: AAAMMxGQ1DmiqHe5c6wF4NpY+GqmYyUD+MqIHJ5cKWMaymQiCgMWbP+N5E5C7SMEubc8PmwPo7dUhdPAw4d+9Ukh0qcCj0XfOehfciSX+wyQjA3tglVdem56gLitTqsOEEGcWSdU9SdfYz/blfgklCL+nTPvF2oW+F4rxV8vUV4/ek91speb+oWstFyKkkES+kimUwY1dRrl3BKuZbXOikz05Peo/IwrznoiQOdTQKZf5iK1fHz7AAeIrg=="
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=debug msg="completed challenge"
Feb 11 03:04:47 volumio go-librespot[25867]: time="2026-02-11T03:04:47-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:49 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:49 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37.
Feb 11 03:04:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:50 volumio go-librespot[25888]: go-librespot daemon starting...
Feb 11 03:04:50 volumio go-librespot[25889]: time="2026-02-11T03:04:50-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:50 volumio go-librespot[25889]: time="2026-02-11T03:04:50-06:00" level=debug msg="app state loaded"
Feb 11 03:04:50 volumio go-librespot[25889]: time="2026-02-11T03:04:50-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:50 volumio go-librespot[25889]: time="2026-02-11T03:04:50-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=info msg="zeroconf server listening on port 42203"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="obtained new client token: AABDhjmyY/V0ls4O8LStqqakNTjxtB9uma3fU2YM3GA8JQJjGgz7/groXeevak1hgGCkBi77BMdB/xiwllxbpN9Au9cTOf/9smrIm25S9gdvQLq8aQ+/jMugBbf63jFvsPHd/i3BUURvJmgw+feAc9jKMmczm/EPHZe9KewVlsd7Ubz1eUlpqEvT5jzxt+bzJ27nvLAaFUf+llKxNMRB3QlQ4okEDjKZnDR/mahnKRsojR9EktAWP9I="
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=debug msg="completed challenge"
Feb 11 03:04:51 volumio go-librespot[25889]: time="2026-02-11T03:04:51-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:52 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:52 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38.
Feb 11 03:04:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:54 volumio go-librespot[25896]: go-librespot daemon starting...
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=debug msg="app state loaded"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-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 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-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 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=info msg="zeroconf server listening on port 46633"
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=debug msg="obtained new client token: AACD5iTcOQSkQWlXkOYEL2fcx1GYyyFJxOlHStuJ8UyDekrJ4p6QQ1TtF7wpdU2TSOiTdhP7pxzIp/WqBASNqj3gPFbzE4VqZ4zpgLzjKorNW08R+TNJUJnEKm9RfPLazkqEYfsR9H1vBDtye3UUoDd+YF9vCgB08wrNcuPXzAB4XvHR5zgyRDq7o/1JaORueEjvhVSCgsxKuYguH3BDoKcxJYrXlUifHcps/qXgODeFV20Uy2j7xj1vzA=="
Feb 11 03:04:54 volumio go-librespot[25897]: time="2026-02-11T03:04:54-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:55 volumio go-librespot[25897]: time="2026-02-11T03:04:55-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:55 volumio go-librespot[25897]: time="2026-02-11T03:04:55-06:00" level=debug msg="completed challenge"
Feb 11 03:04:55 volumio go-librespot[25897]: time="2026-02-11T03:04:55-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:55 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:55 volumio volumio[24925]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:04:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39.
Feb 11 03:04:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:04:58 volumio go-librespot[25907]: go-librespot daemon starting...
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="app state loaded"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="stored credentials not found"
Feb 11 03:04:58 volumio volumio[24925]: info: Initializing connection to go-librespot Websocket
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="new websocket client"
Feb 11 03:04:58 volumio volumio[24925]: info: Connection to go-librespot Websocket established
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-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 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-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 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=info msg="zeroconf server listening on port 38253"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="obtained new client token: AAAvAgIqoIYjAbgYnse3ouG0wmdNp83xCkSlOeGiyWX/eBybHm83Z8gM8//ETqINfPG5BDWiz6ib1FkWU+JXpZbqE5qslb4Y1A9k4yo1aIzgDkhcjBSCFn2OZ/tutRCPN75s8xunVh2a7DcfRcw6V38Kx5yL95qZ3U5bhNaBtLt6h/XTMu4wYg2NT6bfCxgwiV+kO3glSo+pg0EY3ewmmGDkfkUW9fmU8fQRQ9+dXb7pqt951YrQHTOXuQ=="
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="completed keyexchange"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=debug msg="completed challenge"
Feb 11 03:04:58 volumio go-librespot[25908]: time="2026-02-11T03:04:58-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
Feb 11 03:04:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 11 03:04:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 11 03:04:58 volumio volumio[24925]: info: Connection to go-librespot Websocket closed
Feb 11 03:05:01 volumio volumio[24925]: info: Getting Spotify volume
Feb 11 03:05:01 volumio volumio[24925]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 11 03:05:01 volumio volumio[24925]: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 11 03:05:01 volumio volumio[24925]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 11 03:05:01 volumio volumio[24925]: errno: -111,
Feb 11 03:05:01 volumio volumio[24925]: code: 'ECONNREFUSED',
Feb 11 03:05:01 volumio volumio[24925]: syscall: 'connect',
Feb 11 03:05:01 volumio volumio[24925]: address: '127.0.0.1',
Feb 11 03:05:01 volumio volumio[24925]: port: 9879,
Feb 11 03:05:01 volumio volumio[24925]: response: undefined
Feb 11 03:05:01 volumio volumio[24925]: }
Feb 11 03:05:01 volumio volumio[24925]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 11 03:05:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40.
Feb 11 03:05:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:05:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 11 03:05:02 volumio go-librespot[25942]: go-librespot daemon starting...
Feb 11 03:05:02 volumio go-librespot[25943]: time="2026-02-11T03:05:02-06:00" level=info msg="running go-librespot 0.4.0"
Feb 11 03:05:02 volumio go-librespot[25943]: time="2026-02-11T03:05:02-06:00" level=debug msg="app state loaded"
Feb 11 03:05:02 volumio go-librespot[25943]: time="2026-02-11T03:05:02-06:00" level=debug msg="stored credentials not found"
Feb 11 03:05:02 volumio go-librespot[25943]: time="2026-02-11T03:05:02-06:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 11 03:05:02 volumio sudo[25951]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 03:04'
Feb 11 03:05:02 volumio sudo[25951]: 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"