Feb 25 04:02:02 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:02 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Feb 25 04:02:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:03 volumio go-librespot[32407]: go-librespot daemon starting... Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="app state loaded" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-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:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-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:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-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:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=info msg="zeroconf server listening on port 38415" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="obtained new client token: AACgVf+tDso2pOlyaV7fpeHWHARN5RxWcSMQJmj54boKOhoGUEvj2BodyEmjDO8Ub2O0apkLQOWAe6LM5kWgDuSdt2AriQUJk9kG/JMaHhkE6ybZfrr5rvMj6t1s8QBauppCYOzIONCDeyxn3rswSLugaqRJWyKgPicH0b9L3Ue/jJvojQ695fMaUTxNSMFqQ9/gv2HIzRJhtyDRa3ZZRVKKSGjVuYtpaMHWjMaaZXwNdKDcyrr2NW+B8w==" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-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:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=debug msg="completed challenge" Feb 25 04:02:03 volumio go-librespot[32409]: time="2026-02-25T04:02:03-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:05 volumio volumio[31853]: info: BOOT COMPLETED Feb 25 04:02:05 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:05 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Feb 25 04:02:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:06 volumio go-librespot[32430]: go-librespot daemon starting... Feb 25 04:02:06 volumio go-librespot[32431]: time="2026-02-25T04:02:06-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:06 volumio go-librespot[32431]: time="2026-02-25T04:02:06-06:00" level=debug msg="app state loaded" Feb 25 04:02:06 volumio go-librespot[32431]: time="2026-02-25T04:02:06-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:06 volumio go-librespot[32431]: time="2026-02-25T04:02:06-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-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:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-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:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=info msg="zeroconf server listening on port 35783" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=debug msg="obtained new client token: AACPB/xYR/xOFvnwziABaeJoPmuvJbC/9idKScQanxymw0dpDMedjTKZQS//a1M2SS3+TH3q69xEmlZARaY28nmq7LlahbJ89Sq9BMh14zRoR5Oo5xhuBUFNjLygHuzh+N1prxs27DjjGnBD2fEQ3+1rbJtQ5w+8Eqyc0ro6sYcb+m8CeE4dS+vEPToGvbsMqcYQkNTWgimfoJw7v9D8Ku1WaAajn4A9cXe+QReNxGaeFgI455N1CM0G3g==" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-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:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=debug msg="completed challenge" Feb 25 04:02:07 volumio go-librespot[32431]: time="2026-02-25T04:02:07-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:08 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:08 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Feb 25 04:02:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:10 volumio go-librespot[32438]: go-librespot daemon starting... Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=debug msg="app state loaded" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 25 04:02:10 volumio go-librespot[32439]: time="2026-02-25T04:02:10-06:00" level=info msg="zeroconf server listening on port 43141" Feb 25 04:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-06:00" level=debug msg="obtained new client token: AAA/o+b5YSapLwU25Vde9zZbYyI4Qk2oepBPxRgbRc30kMsd7HYN6/3i7ik51YWOZl+Y+qWGbDMtnXfc9poT1uhpRSwsPmjTCIRNA7rMXzzWJwaSHwXyfWRj05Wi5pfF8PLW+Rtiu3JFFuM+du9TgckNqWJw12yUoNBDq9CJ1eTjD7wIBRgS+nNEXkqvUzaE4ttdk76udNvW/CxtAeq7xCz2AVgxXBBTnKBZKY+JSYif141IO42Rn9Y=" Feb 25 04:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-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:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 25 04:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-06:00" level=debug msg="completed challenge" Feb 25 04:02:11 volumio go-librespot[32439]: time="2026-02-25T04:02:11-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:02:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:11 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:11 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Feb 25 04:02:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:14 volumio go-librespot[32449]: go-librespot daemon starting... Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="app state loaded" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-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:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-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:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=info msg="zeroconf server listening on port 41829" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="obtained new client token: AADTK7vD/DE9xh7+a7N7pF21kW+WU24xBtnZ84yDlu2B+mcfoVncnNXByD+N6hkDV+shs1R9yzIMfsRctEoUootJht2x+qpZw3UOMkb8TB8HdtHM+AEJ+kz1wDZgmCFU2GEVwL5AwtHJk1fYJStOLv7W+8PWlsaBgUDNyLPoJGIDhThyRXWkFRDTVLzizle6EwPbHRUru43/+TRxFLaLjZIZykRKjL0a6yWbuKrg1sqVYm1OryPz9QU+xA==" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=debug msg="completed challenge" Feb 25 04:02:14 volumio go-librespot[32450]: time="2026-02-25T04:02:14-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:14 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:14 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:17 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:18 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Feb 25 04:02:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:18 volumio go-librespot[32471]: go-librespot daemon starting... Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="app state loaded" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-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:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-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:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-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:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=info msg="zeroconf server listening on port 35167" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="obtained new client token: AAColXkfZJUYhT88M7avNEiAHvicxbyT2oUmDpXzMw/WgmDE3lGHx5dDB1jNeY2MzKxgy/Wu+3pp5orheUkWVjicLZlqQmd6p2Cwfc6QDP5RydzYEgQz1qjg7R29bhzdVN7OUEXmP0n0RgaCx+OtQj29XxIweGPBIQ8LIC8mJT2VOBDavC3tecKRf76qElhKq/iZX60zLAxtwJhM2CxnyUSa1NFFwWFg1T3Slvg4b85j0k+QJIY6S+tP7Q==" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=debug msg="completed challenge" Feb 25 04:02:18 volumio go-librespot[32472]: time="2026-02-25T04:02:18-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:20 volumio volumio[31853]: info: UPDATER: Scheduling automatic update Feb 25 04:02:20 volumio volumio[31853]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime Feb 25 04:02:20 volumio volumio[31853]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime Feb 25 04:02:20 volumio volumio[31853]: info: UPDATER: Auto update will take place at: Thu Feb 26 2026 05:39:27 GMT-0600 (Central Standard Time) Feb 25 04:02:21 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:21 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Feb 25 04:02:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:21 volumio go-librespot[32479]: go-librespot daemon starting... Feb 25 04:02:21 volumio go-librespot[32480]: time="2026-02-25T04:02:21-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:21 volumio go-librespot[32480]: time="2026-02-25T04:02:21-06:00" level=debug msg="app state loaded" Feb 25 04:02:21 volumio go-librespot[32480]: time="2026-02-25T04:02:21-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:21 volumio go-librespot[32480]: time="2026-02-25T04:02:21-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-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:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-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:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-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:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-06:00" level=info msg="zeroconf server listening on port 44833" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-06:00" level=debug msg="obtained new client token: AACIQuspGwbfgmb2l/X/h19JmbptRRnE+aoWvY+HHixlVKqPo7Gh4H9Cf0jakHeETwAQEAhiHBG9njf8q8fOH4LSWDusosJd/UQTYHW+fRZHn2OWSXvXr3tSIOtEfJMjkLN1dyUmzgz8f03O3PmyQu2tgvcNy7fXeXh/a8/8ovE9I6KJ6JLJoXruTwOrU+Z4Xyju3106U/C30fwZkpR4fJJHQkAoZXCEQXOaneDWlizLC1XCHabH4Ws=" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-06:00" level=debug msg="completed challenge" Feb 25 04:02:22 volumio go-librespot[32480]: time="2026-02-25T04:02:22-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:02:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:24 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:24 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Feb 25 04:02:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:25 volumio go-librespot[32489]: go-librespot daemon starting... Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=debug msg="app state loaded" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 25 04:02:25 volumio go-librespot[32490]: time="2026-02-25T04:02:25-06:00" level=info msg="zeroconf server listening on port 42131" Feb 25 04:02:26 volumio go-librespot[32490]: time="2026-02-25T04:02:26-06:00" level=debug msg="obtained new client token: AABPlGmMvbUj0d3kK1y6QEgdrUiyyHewfxXmapFyIDu13YkNcNsCbC7utETIQ9rAYupYAK8htzZvx1gUe1GrH7fZZSlBTgot/1BlNLdedy1kq5n8+SYSyhR1+yj6WZBakt1pFbQL/5JyRjzhaJuO9P3/CJn6lUVyRL8iKQaFUY0ah6nrRYXgZXciZLRc/hvyB0RsI6rf/xiPm1/cxmrRkYMOjO+0dOPi0OF+tRQtxWXq92SJ3FmCiic=" Feb 25 04:02:26 volumio go-librespot[32490]: time="2026-02-25T04:02:26-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:26 volumio go-librespot[32490]: time="2026-02-25T04:02:26-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:26 volumio go-librespot[32490]: time="2026-02-25T04:02:26-06:00" level=debug msg="completed challenge" Feb 25 04:02:26 volumio go-librespot[32490]: time="2026-02-25T04:02:26-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:02:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:27 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:27 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Feb 25 04:02:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:29 volumio go-librespot[32511]: go-librespot daemon starting... Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="app state loaded" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-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:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-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:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=info msg="zeroconf server listening on port 40573" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="obtained new client token: AADqkHd3yu/kEkb2Iv9FsTLvNVjEMa1ftQF1X7Kt2zF8sg5bmkuFnXCIIGumGUtJet3XIlCSGEFdG6pYEP9pCaTpF5cIjB3U4WslODDplesfd2gz5lIwES6Z6vl9ucoTrfqVZsMyr1iExODp12VkAfYBoPr+0MaOPBctaSTgYAYnzgsB/EJ+cbPOx+S+f/uI9IyjxkKDwL+vEKpXsoJCrzLZrPkj1hGGjWMMW4H8UssKTfLB8GKtKGdRDg==" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=debug msg="completed challenge" Feb 25 04:02:29 volumio go-librespot[32512]: time="2026-02-25T04:02:29-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:30 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:30 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:33 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:33 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Feb 25 04:02:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:33 volumio go-librespot[32522]: go-librespot daemon starting... Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="app state loaded" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-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:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-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:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-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:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=info msg="zeroconf server listening on port 38585" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="obtained new client token: AABZvDh+tnCCl+zICxuuQR2OE5uv4hIA7bgawZq06COFklUoKoXiks19CjgI7nu40kzZOVdhB5oegDYF4l0N/QEMTiFl0C+vQ0FWeigerICk6zWcLAOGxLW5diK9/WNlvs0aA/iHSd+e8oIDSHRkuzx1YhFSMT7LY4yxGmtFR+xzbNMrC6nB6ofQNjHabDFkVTsMXC//MvJWNMdiSLFXvlSMzGYGSC/pp7i57X+WeGKj+FYmEQomquw41w==" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=debug msg="completed challenge" Feb 25 04:02:33 volumio go-librespot[32523]: time="2026-02-25T04:02:33-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:36 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:36 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Feb 25 04:02:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:36 volumio go-librespot[32544]: go-librespot daemon starting... Feb 25 04:02:36 volumio go-librespot[32545]: time="2026-02-25T04:02:36-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:36 volumio go-librespot[32545]: time="2026-02-25T04:02:36-06:00" level=debug msg="app state loaded" Feb 25 04:02:36 volumio go-librespot[32545]: time="2026-02-25T04:02:36-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:36 volumio go-librespot[32545]: time="2026-02-25T04:02:36-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=info msg="zeroconf server listening on port 34225" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="obtained new client token: AAAlBvL4dR1RJwYxOzoojztYSwBEWBjVHugbZrIUvhCBLevKTYCQQ4ePOsmoib9xuqh+G7HtdRgAhtUxxhsRKQQkX2tatvukpZTTTUtS02pXL+xfN1K88sqSagaBbaPSDqAcOPcipm12HRWuzsnuvH+BN9MTWX4BHeZsErbGhMtIGe8c+K38dK4J7ZqhYKgmOqbQkQrqtS2pPMI9QLI5thP2ubZDoTE63nOmL0oZtBs8syU0tHt6mcc2vQ==" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:4070, retrying with a different AP" error="dial tcp 104.154.127.247:4070: connect: connection refused" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=debug msg="completed challenge" Feb 25 04:02:37 volumio go-librespot[32545]: time="2026-02-25T04:02:37-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:39 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:39 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Feb 25 04:02:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:40 volumio go-librespot[32552]: go-librespot daemon starting... Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=debug msg="app state loaded" Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-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:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-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:02:40 volumio go-librespot[32553]: time="2026-02-25T04:02:40-06:00" level=info msg="zeroconf server listening on port 40839" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-06:00" level=debug msg="obtained new client token: AABFZ9vdDYdACkoRTJ1iiVF32r01/kztrzRjcygiR6+u690vOZXgDlaDPB4Rh3TUQJYP+2Ok/HI7nabyKGtZ8ET+IxMlFHG/PLRvfI2IrrIBz1PLgxGVTTlV6usgK/8Sj/Z3FQOqipJxQTBO9cAJTuns7RrAEoazbtDP6GZqlhJqS93AdPPrgJA6jqJFTlCDPAzUxdKaSPw8vR0qaCStNCtblglgUpAf4HrFAzj6LeSRnzgrKiZVuGY=" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-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:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-06:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:443, retrying with a different AP" error="dial tcp 104.154.127.247:443: connect: connection refused" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-06:00" level=debug msg="connected to ap-guc3.spotify.com:80" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-06:00" level=debug msg="completed challenge" Feb 25 04:02:41 volumio go-librespot[32553]: time="2026-02-25T04:02:41-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:02:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:42 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:42 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Feb 25 04:02:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:44 volumio go-librespot[32561]: go-librespot daemon starting... Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="app state loaded" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-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:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-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:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=info msg="zeroconf server listening on port 43241" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="obtained new client token: AABYNHZwLf7WDFp65Bh397YfVgQSsfzG17yY0FdviiKPLx7Y8kpmyyQ5ArCCM1Z/75JzNxcVjfPbx8qOZf/+ParZbfqBY3G/9SYmcu7njiKyLgCqaw8U7Yvrizf7huGCVfo8tmggbJPcSPdOnWDmZ0jFPexDUURKAt0VOG39ti8QdEQPkUVv8rcco8CTrupz0Z3OC2I1EvOUmAGDjM4a0F682DUT67DTGEeAC3j1jV65ZgNZWwnZJSS7gg==" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=debug msg="completed challenge" Feb 25 04:02:44 volumio go-librespot[32562]: time="2026-02-25T04:02:44-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:45 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:45 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:48 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:48 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Feb 25 04:02:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:48 volumio go-librespot[32583]: go-librespot daemon starting... Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="app state loaded" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-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:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-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:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-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:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=info msg="zeroconf server listening on port 38765" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="obtained new client token: AAAjDo+FEXNypin/lt9Xz9inlYl/q0uDrmtPB2ZKl7k/pb9lFXpUirCyBAdW1yU4kb8LUNV+2/8XETtqVwmN1nbO9vsGWVvtpQtZ19Xiq6HkvDg/bGiWYihFkZHcKekV6XrDamjXtUZfmQFYvL/vMyzcWka3TXkaM1JCh8pf+x6sxbwkxQI1vaJ/Hvjqd4sKUZLQphoRL4sSXcLJJh+LdCqLG/xlCFjIp2M+ixejdSrgSQwECh1DVPHjVA==" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=debug msg="completed challenge" Feb 25 04:02:48 volumio go-librespot[32584]: time="2026-02-25T04:02:48-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Feb 25 04:02:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:51 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:51 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Feb 25 04:02:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:51 volumio go-librespot[32594]: go-librespot daemon starting... Feb 25 04:02:51 volumio go-librespot[32595]: time="2026-02-25T04:02:51-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:51 volumio go-librespot[32595]: time="2026-02-25T04:02:51-06:00" level=debug msg="app state loaded" Feb 25 04:02:51 volumio go-librespot[32595]: time="2026-02-25T04:02:51-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:51 volumio go-librespot[32595]: time="2026-02-25T04:02:51-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-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:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-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:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-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:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-06:00" level=info msg="zeroconf server listening on port 41569" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-06:00" level=debug msg="obtained new client token: AABrhQswssPFEcvzArcX0O/G99NSnQf/y6jSCYjIFZXFpmj3RdPdhbe+YILAkpVob16rNVvVcf+su7o9kAhyslw+dm2fxteTaM9OuI+QEo742/Ty5yBpmuKlRMTNhVTSMyX9X+iphJVNLeBPSlFgW+s6AlEKjaRCaAfkloq694dSIZvnQE789HqLoXpttkC2w6O9lmPCxAd5m0EM/R2MAwzq9I6KHulTHKpmvBGcBvxiBbE7dBC3uPxjEQ==" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-06:00" level=debug msg="completed keyexchange" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-06:00" level=debug msg="completed challenge" Feb 25 04:02:52 volumio go-librespot[32595]: time="2026-02-25T04:02:52-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:02:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:02:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:02:54 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:54 volumio volumio[31853]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 04:02:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Feb 25 04:02:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 04:02:55 volumio go-librespot[32602]: go-librespot daemon starting... Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=info msg="running go-librespot 0.4.0" Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=debug msg="app state loaded" Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=debug msg="stored credentials not found" Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 25 04:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-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:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-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:02:55 volumio go-librespot[32603]: time="2026-02-25T04:02:55-06:00" level=info msg="zeroconf server listening on port 43193" Feb 25 04:02:57 volumio volumio[31853]: info: Initializing connection to go-librespot Websocket Feb 25 04:02:57 volumio go-librespot[32603]: time="2026-02-25T04:02:57-06:00" level=debug msg="new websocket client" Feb 25 04:02:57 volumio volumio[31853]: info: Connection to go-librespot Websocket established Feb 25 04:03:00 volumio volumio[31853]: info: Getting Spotify volume Feb 25 04:03:00 volumio volumio[31853]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 25 04:03:00 volumio volumio[31853]: info: CoreCommandRouter::volumioGetState Feb 25 04:03:00 volumio volumio[31853]: info: CorePlayQueue::getTrack 0 Feb 25 04:03:00 volumio volumio[31853]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 25 04:03:00 volumio volumio[31853]: SPOTIFY: SPOTIFY VOLUME undefined Feb 25 04:03:00 volumio volumio[31853]: SPOTIFY: VOLUMIO VOLUME 100 Feb 25 04:03:00 volumio volumio[31853]: info: Aligning Spotify Volume to Volumio Volume Feb 25 04:03:00 volumio volumio[31853]: info: CoreCommandRouter::volumioGetState Feb 25 04:03:00 volumio volumio[31853]: info: CorePlayQueue::getTrack 0 Feb 25 04:03:00 volumio volumio[31853]: info: Setting Spotify Volume from Volumio: 100 Feb 25 04:03:01 volumio go-librespot[32603]: time="2026-02-25T04:03:01-06:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: invalid status code from clienttoken: 504" Feb 25 04:03:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 04:03:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 04:03:01 volumio volumio[31853]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 04:03:01 volumio volumio[31853]: Error: socket hang up Feb 25 04:03:01 volumio volumio[31853]: at connResetException (node:internal/errors:720:14) Feb 25 04:03:01 volumio volumio[31853]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 25 04:03:01 volumio volumio[31853]: at Socket.emit (node:events:526:35) Feb 25 04:03:01 volumio volumio[31853]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 25 04:03:01 volumio volumio[31853]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 25 04:03:01 volumio volumio[31853]: code: 'ECONNRESET', Feb 25 04:03:01 volumio volumio[31853]: response: undefined Feb 25 04:03:01 volumio volumio[31853]: } Feb 25 04:03:01 volumio volumio[31853]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 04:03:01 volumio sudo[32638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 04:02' Feb 25 04:03:01 volumio sudo[32638]: 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"