Dec 10 16:56:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Dec 10 16:56:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:01 volumio go-librespot[22754]: go-librespot daemon starting... Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="app state loaded" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=info msg="zeroconf server listening on port 33553" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="obtained new client token: AAB0ItlFEo+0FExEdB3VFi1kPtCl8MMWgnf6XtVeci4ORxFmu6vhbgORmOLOmT80I3HwUj0GFqsiO2mna6flALA1rbKl8EP2Fcdto6JXJhqErhC4I32/RmW+WgJ9nfha8qVkTQIEWTDniyVyDW0WbdFxJZ0eFUovLYk4ygYvw/sAoVmHxMlS25+D3UT7l3Idxjou2WquKZy9MLp/eVnOkNFNnCcOt3bnoow1mSYsBAJ89DBdyhMFOF58BA==" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56:02-06:00" level=debug msg="completed challenge" Dec 10 16:56:02 volumio go-librespot[22755]: time="2025-12-10T16:56: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 " Dec 10 16:56:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:02 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:02 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:05 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:05 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Dec 10 16:56:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:05 volumio go-librespot[22762]: go-librespot daemon starting... Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=debug msg="app state loaded" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-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]" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-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]" Dec 10 16:56:05 volumio go-librespot[22763]: time="2025-12-10T16:56:05-06:00" level=info msg="zeroconf server listening on port 41357" Dec 10 16:56:06 volumio go-librespot[22763]: time="2025-12-10T16:56:06-06:00" level=debug msg="obtained new client token: AADt0mmwtF2rwc/GBf88LsRr24IgnUjECm6/eKPNvIViDVGgjxFHCpIcghOEg0vTRkm+Mxp0ulkliPieBNCZ+xlur9jlSEvkdmIYF7PaD+5eKjhM+olpEKj1ZevuB3XKTUecwevBs7We3h8vPESzggvcpT+zuJqUZoIin+PahdJ8WNIFFAhhYuyT5LEMXAP4HY36OTNq6RoEnjprEIHVi36HQg/sy8NHPtEc58ix6D+qtw1aRzEF7MY=" Dec 10 16:56:06 volumio go-librespot[22763]: time="2025-12-10T16:56:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:06 volumio go-librespot[22763]: time="2025-12-10T16:56:06-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:06 volumio go-librespot[22763]: time="2025-12-10T16:56:06-06:00" level=debug msg="completed challenge" Dec 10 16:56:06 volumio go-librespot[22763]: time="2025-12-10T16:56: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 " Dec 10 16:56:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:08 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:08 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:08 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 10 16:56:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Dec 10 16:56:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:09 volumio go-librespot[22786]: go-librespot daemon starting... Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="app state loaded" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56: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]" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56: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]" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56: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]" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=info msg="zeroconf server listening on port 34007" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="obtained new client token: AADd5jL9BTjz9HAJO63mT4/tyDP8C+xqMbC7kECvb8f6ks5U7aZGVqiO16shLXKjscEl8IkARRexGhT6U1C0xRnJdDBAbhHQ9Hr0Q5VFC05YlVioGiSQJMnfta5ty4aMYhbgC9Uz6wQzt7Ek3PA+T8W/pRp/9iS+cg1/JwNRFgp9DgYSD5+0Kbg6FF13HbIJo9JuhYboCm9KF2bwSNqLpVvyJndHwFeWsLJ0Fc0V+PkvjrA4FEwrfi/VgA==" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:09 volumio go-librespot[22787]: time="2025-12-10T16:56:09-06:00" level=debug msg="completed challenge" Dec 10 16:56:10 volumio go-librespot[22787]: time="2025-12-10T16:56: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 " Dec 10 16:56:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:10 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 10 16:56:10 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 10 16:56:11 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:11 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:12 volumio volumio[22080]: info: UPDATER: Scheduling automatic update Dec 10 16:56:12 volumio volumio[22080]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime Dec 10 16:56:12 volumio volumio[22080]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime Dec 10 16:56:12 volumio volumio[22080]: info: UPDATER: Auto update will take place at: Thu Dec 11 2025 04:31:49 GMT-0600 (Central Standard Time) Dec 10 16:56:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Dec 10 16:56:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:13 volumio go-librespot[22818]: go-librespot daemon starting... Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="app state loaded" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56: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]" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56: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]" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56: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]" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=info msg="zeroconf server listening on port 46827" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="obtained new client token: AACbxUKpRzVFOl7OqvIUS3Z5rhbtNxMzehMLPN0W7e6bhRPE6ywgv199NKigF+HzoUemCzLaiKZWC8Xk7DKYqsolVUDPuq42sjOKhgAIVeW2429AtIztO1Dj+vHagFRwxJC6lOlfKj3GtRe4tW3GGwItv0kWnzgH0zJEQR6P+40EGrR3LpVvDXLH/yVsDqaU3DvGGU3aYX3m+rAelq+zPl8cgsSE/t/AjaIoJ8CC2hNgu2s0BSIsMAr99Q==" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56:13-06:00" level=debug msg="completed challenge" Dec 10 16:56:13 volumio go-librespot[22819]: time="2025-12-10T16:56: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 " Dec 10 16:56:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:14 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:14 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Dec 10 16:56:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:16 volumio go-librespot[22826]: go-librespot daemon starting... Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="app state loaded" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56: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]" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56: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]" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56: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]" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=info msg="zeroconf server listening on port 41037" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="obtained new client token: AAAYuqU7Dx+PI6iCgHEI6c5XJnve15UV5o9f+uICl6BGCciSh22imBuxNC2RF5KpaIrzdpIoWIAh6Fmr+6m9+qiA+8Sxzt658qJHJUPgttZSUKxi26+ja0/goOMP5xJF18/HZ8Va/xzBAOAf3er0Jm+M8NNR0FK9k36AoMicW0O8x5pKAFQi9mtV7EV6wNPrikyad504o5KFjCWT2OtO26N5w1YQYlC79wEMHiy+XYp91j3cvNy94WezTw==" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56:17-06:00" level=debug msg="completed challenge" Dec 10 16:56:17 volumio go-librespot[22827]: time="2025-12-10T16:56: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 " Dec 10 16:56:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:17 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:17 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:20 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:20 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Dec 10 16:56:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:20 volumio go-librespot[22848]: go-librespot daemon starting... Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=debug msg="app state loaded" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-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]" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-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]" Dec 10 16:56:20 volumio go-librespot[22849]: time="2025-12-10T16:56:20-06:00" level=info msg="zeroconf server listening on port 35583" Dec 10 16:56:21 volumio go-librespot[22849]: time="2025-12-10T16:56:21-06:00" level=debug msg="obtained new client token: AABSD9qD7ygLXNQbx/mVRDxSOceM93tHY99AgLlT7pSvnwqm40UlJRXm2L3TBUkorWX8vn0Bg7/pmrcFqGMVgk/McvQEQodmQOI3tYY7Mqz404/C/JlpCrDqwIUp4Mlr3TepnSPRZrJkMnPetEt3FRWZb6o3u4KTvY/TGXgntXSBUiS68aiG/c9t6Ca5c8amyMs52vYoHS0wkEs65rugEjZbsazXZh1deK6dXMEW2QmSrzN+vICcwVk=" Dec 10 16:56:21 volumio go-librespot[22849]: time="2025-12-10T16:56:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:21 volumio go-librespot[22849]: time="2025-12-10T16:56:21-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:21 volumio go-librespot[22849]: time="2025-12-10T16:56:21-06:00" level=debug msg="completed challenge" Dec 10 16:56:21 volumio go-librespot[22849]: time="2025-12-10T16:56: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 " Dec 10 16:56:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:23 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:23 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 61. Dec 10 16:56:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:24 volumio go-librespot[22859]: go-librespot daemon starting... Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="app state loaded" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-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]" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-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]" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=info msg="zeroconf server listening on port 39383" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="obtained new client token: AAD6KVrXdJACbI7ZbJ8Q3HE4EGMnEpGMRLsxmbtSLRHmfTkuYVITxUz1WhAECpPKFiANcSQOZH/Qzp+aWpayxRBrujqpLEzVT5IK6trqzIEXkTd8hV8BtBrDit682o57T5KmV50Y3/8j3RFP54Ha4+ODSmIYEBOpNI1VTjx0Wn+gs9BQskuF5vBpHT3iugAXELREt399wEErsHMCpv7V4lXKhOnE1d95xEle7PvKZL6OVqHETBpKqUyssw==" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:24 volumio go-librespot[22860]: time="2025-12-10T16:56:24-06:00" level=debug msg="completed challenge" Dec 10 16:56:25 volumio go-librespot[22860]: time="2025-12-10T16:56: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 " Dec 10 16:56:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:26 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:26 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 62. Dec 10 16:56:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:28 volumio go-librespot[22867]: go-librespot daemon starting... Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="app state loaded" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56: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]" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56: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]" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56: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]" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=info msg="zeroconf server listening on port 44983" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="obtained new client token: AAAj5dXwZgb33sMb1as9el516a7c077QuHjUvKZKvKgwPG2b2sUcjiwOlLTZBRIOrEw1H09xvHQzkYlJj/hTnIVzYYvQGc0KyCJjkafYQBbyaX/ArHcwGVwUx/dXq5VR81B5+VLwbaqaTL2NoUEX32nEbN2jIfHufNvOAoDdzMxbnFsbaUnTknhiOOFVe7pQEIBCbahcDDHIMPWDKzQU2Zf8IakWz2pd6SbInIUflhHQ7v1kwbekDxT9Zw==" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56:28-06:00" level=debug msg="completed challenge" Dec 10 16:56:28 volumio go-librespot[22868]: time="2025-12-10T16:56: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 " Dec 10 16:56:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:29 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:29 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 63. Dec 10 16:56:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:32 volumio go-librespot[22892]: go-librespot daemon starting... Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="app state loaded" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-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]" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-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]" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=info msg="zeroconf server listening on port 39133" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="obtained new client token: AADGg7dNJ85LKus2FOHh0EAAnaDFVV7hNRoH1zGjwyYHT9gw4itR+OpS1NWQQh7B/kueAEgc+fLEn0NQO4xhdQcFiNwBRtrSZ344eJIoxnNqE/OWCzy2CCxstrM1wvyI9RqI+tLC8OyDD/wn/QWzvWeEu/9P0XjIvPJw+A+Up/TxmSSzsvmLx+23IQ68OjkxNaP43a0nbdwFYx1XAEb3+rlRz1jAZCEnRG6PjJOwI8lUJSYyHd2y4lDc7A==" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-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" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56:32-06:00" level=debug msg="completed challenge" Dec 10 16:56:32 volumio go-librespot[22893]: time="2025-12-10T16:56: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 " Dec 10 16:56:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:32 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:32 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 64. Dec 10 16:56:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:35 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:35 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:35 volumio go-librespot[22900]: go-librespot daemon starting... Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-06:00" level=debug msg="app state loaded" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-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]" Dec 10 16:56:35 volumio go-librespot[22901]: time="2025-12-10T16:56:35-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]" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56:36-06:00" level=info msg="zeroconf server listening on port 34121" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56:36-06:00" level=debug msg="obtained new client token: AAAGDpbYpwxXpMFec76G0Apml7BwLEJq1eMcbutkyjzFyTTz3sal91CYOhT2c0ymGdQJ6tAJp9TO3kamLHkBxZGBaEZhpzCGMNJ1GCvXJ4XTQjrLO5sFh7Uu9r3FnInUGgt1ngmnWBKpdGIoTMIOhhx0SIzjURH6lkSyWcBW/neF4dQeGX2tf679tKuSkOaPXS94p8b9W1yAoVp3KTsJZZ+BqtCZsTHV1hK0XFdDwspJg6FJHTq4E8w=" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56:36-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56:36-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56:36-06:00" level=debug msg="completed challenge" Dec 10 16:56:36 volumio go-librespot[22901]: time="2025-12-10T16:56: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 " Dec 10 16:56:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:38 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:38 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 65. Dec 10 16:56:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:39 volumio go-librespot[22908]: go-librespot daemon starting... Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="app state loaded" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-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]" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-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]" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=info msg="zeroconf server listening on port 35405" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="obtained new client token: AAC1IDJNZOdbVU5ANpIcxN0xON346yc+B8Cn6yvR4tb2BGnRHViIkjygjgREL0RaiPfcfTxhCHwiYpcITDxCSDwdJZHHxHdVxV8VYbeogaajvcNkX1ltK2Nrt6oWI3VhhRBVuakZEsfxMLCnxyw7pAYLwXf5KwppvkMwvi3DJDlVjDQBszeCgREdBKhKI5ryJWQQ6Si9stL/fxlVHJv9+/8Z0dazlrXiV6y+5/XCJGrdCy0xqIAR3ncImw==" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=debug msg="completed challenge" Dec 10 16:56:39 volumio go-librespot[22909]: time="2025-12-10T16:56:39-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Dec 10 16:56:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:41 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:41 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 66. Dec 10 16:56:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:43 volumio go-librespot[22933]: go-librespot daemon starting... Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="app state loaded" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-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]" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-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]" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=info msg="zeroconf server listening on port 43411" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="obtained new client token: AAArAcBTUcRegPEBUl2jyHyJiqvGaz1Hjr1GuhqmWHbH/jZnqAm5KkVGOdXFR8GJpML9s7a8kw8cEwBt74j6UBsdZvZ4ayxx6bMnH/AdpGV/mjPzEawxSKwjOpVc7IoIZD/ilwNTp36nHDSPSrcfo5n6jaMDXx72Kd6xotpJ8JVU/TM4pgSQ8719lO7gG38Ap7PBC2flechJ4yj+cJwmJN34YgDZ++Y6J7HmvxP3j+YuTMBStFBHi/JYJw==" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56:43-06:00" level=debug msg="completed challenge" Dec 10 16:56:43 volumio go-librespot[22934]: time="2025-12-10T16:56: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 " Dec 10 16:56:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:44 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:44 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 67. Dec 10 16:56:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:47 volumio go-librespot[22941]: go-librespot daemon starting... Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="app state loaded" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56: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-gew1.spotify.com:80]" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-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]" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-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]" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=info msg="zeroconf server listening on port 40235" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="obtained new client token: AABjpfSq3/HdMtlsdbEdVDNDWdsIbI+6BzzMIZzw8caUYi23dkmgRzJSIEN7xA91G6++sw7WT4JjZk+UEZ486G8Is1xST6AOGUFsrHmMIic97cCAKnwzmJ37UjRolEmGGZ28PjETO74xIGE6+5Y5/rXZ1ScedBKPi+90a5/TojzENtame6KbGOxlmtTLA2e/1CYn88JtzCgHsgzEqxxYaHR8gfKt6aeePYt+OCBseJ4CjmbjkPM9NikUaA==" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56:47-06:00" level=debug msg="completed challenge" Dec 10 16:56:47 volumio go-librespot[22942]: time="2025-12-10T16:56: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 " Dec 10 16:56:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:47 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:47 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 68. Dec 10 16:56:50 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:50 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:50 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:50 volumio go-librespot[22963]: go-librespot daemon starting... Dec 10 16:56:50 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=debug msg="app state loaded" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-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]" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-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]" Dec 10 16:56:50 volumio go-librespot[22964]: time="2025-12-10T16:56:50-06:00" level=info msg="zeroconf server listening on port 44413" Dec 10 16:56:51 volumio go-librespot[22964]: time="2025-12-10T16:56:51-06:00" level=debug msg="obtained new client token: AAB9P/a51qjyFoqj5ByfZcsIIwoPqIxMrVXq04lUVhwFHbDcfoWArHzO+npTCPfcICLJIhe6Uqxbtf/IK9dql03ZtUWqJVrFNi0m0SHSQGEHHc0Jljf/i9FC0w/CCgOREB8ffSNY3zTljTCyjqDIl4nFHwkPqMMC5lDP/PEfXnV8WOvUzZCBx0sqGuIVyMJzda/mj/N3VA2E6DfvrnhD+NzsRhOOCSf2+BhuR292ZeIpHprRwLtGQ5Q=" Dec 10 16:56:51 volumio go-librespot[22964]: time="2025-12-10T16:56:51-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:51 volumio go-librespot[22964]: time="2025-12-10T16:56:51-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:51 volumio go-librespot[22964]: time="2025-12-10T16:56:51-06:00" level=debug msg="completed challenge" Dec 10 16:56:51 volumio go-librespot[22964]: time="2025-12-10T16:56: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 " Dec 10 16:56:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:53 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:53 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 69. Dec 10 16:56:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:54 volumio go-librespot[22972]: go-librespot daemon starting... Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="app state loaded" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56: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]" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56: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]" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56: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]" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=info msg="zeroconf server listening on port 39323" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="obtained new client token: AACMe5Y3ukXvOCvluz0Iu5H6t1M48A3CUWZDne7Uo1VF1QzG1i4TzuBjQA5M1aY6VX7V0xnD5be8Bn5itWRHpV0usKY+NWAuxKA+pAuib3aiazZIpIw5HCfMohtF26EHluVF70Q0w9Jvr8xADQ2y71HvmLqPSFE2Ya/zfFQXbOD10UEniHRoVddgK5Xt8BYSfGQpq23YTzUTGZ465fsmhK4PZDvlyJw/4BX9kYN2K97wUFCggVKcYaWGLg==" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:54 volumio go-librespot[22973]: time="2025-12-10T16:56:54-06:00" level=debug msg="completed challenge" Dec 10 16:56:55 volumio go-librespot[22973]: time="2025-12-10T16:56: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 " Dec 10 16:56:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:56 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:56 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:56:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70. Dec 10 16:56:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:56:58 volumio go-librespot[22980]: go-librespot daemon starting... Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="app state loaded" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="stored credentials not found" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56: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]" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56: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]" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56: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]" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=info msg="zeroconf server listening on port 46001" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="obtained new client token: AACMRPV8lrXubrGTUz5tpaJtkOhWdZa7Uy8N9L9uOLtTqOOjl6FTT05s051LJgqMWHVNGPKY6//Mhh34eEPMTVVHZcrehs0tw+cQxvS5DsWjpwbgW6obz7X2aI83KloGI2/7p0pyP/vK+//ZklGr+oNrq7lPDO0mDaf/0/iBl+SfTWbLMz/2OKpYa33cQIh2AuhZrZVDIhq6D8IuNgczr4hUmev0TqN7cbqxXQGslP54vUw3qwrr/qXYPQ==" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="completed keyexchange" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56:58-06:00" level=debug msg="completed challenge" Dec 10 16:56:58 volumio go-librespot[22981]: time="2025-12-10T16:56: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 " Dec 10 16:56:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:56:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:56:59 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:56:59 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 71. Dec 10 16:57:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:01 volumio go-librespot[23005]: go-librespot daemon starting... Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="app state loaded" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=info msg="zeroconf server listening on port 35501" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="obtained new client token: AADgPlwTU19JMM2LFaA/iyBKxOEf/UNW0iYlpFLptDS6cJDuHiu4os4AYjXJNdVDFuVOJZC5U2jNEAsT5kbz0Hzvntpb7bHrPqb5klvWV3ZCB9GPPQzTZNLtVRlPbwjoBeS5ulZMBOG4ZE0gOFg23h1Vz/MU44rDRokl71xNN//kTJTyYMogyXwhV/bE6vB4WLgg+r7fQUPmxZMQuO5tbZoPHoEQQYge003iNc0zZEZ2rjSPW1Vqz9RlwA==" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57:02-06:00" level=debug msg="completed challenge" Dec 10 16:57:02 volumio go-librespot[23006]: time="2025-12-10T16:57: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 " Dec 10 16:57:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:02 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:02 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 72. Dec 10 16:57:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:05 volumio go-librespot[23013]: go-librespot daemon starting... Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:05 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=debug msg="app state loaded" Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:05 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-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]" Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-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]" Dec 10 16:57:05 volumio go-librespot[23014]: time="2025-12-10T16:57:05-06:00" level=info msg="zeroconf server listening on port 45821" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57:06-06:00" level=debug msg="obtained new client token: AAALYOZ//QWGf6cx8QIj+gS44zl94S/0eotWw/aWFPz5oOPNcaVR9A3UXM0th1m6F6wVTHu3URx0HB4XGuIdz09N2N2PAQmGtdCPqER7+zzSWWz/cU2VtWsS0dWG0TEyQSvZldlpNgAlbMLTk2Lhd2XKBVftcbdh4nk949Czx4bSkZ88urA7Jr4+ekEk3wIKZKfCgXP8NGVzB8FiUy3PlV1KYMOZ4pA5jRq3PJZB0nHBJS015zVPMxQ=" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57:06-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" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57:06-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57:06-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57:06-06:00" level=debug msg="completed challenge" Dec 10 16:57:06 volumio go-librespot[23014]: time="2025-12-10T16:57: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 " Dec 10 16:57:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:08 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:08 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Dec 10 16:57:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:09 volumio go-librespot[23021]: go-librespot daemon starting... Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="app state loaded" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57: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-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-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]" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-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]" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=info msg="zeroconf server listening on port 43475" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="obtained new client token: AADJBgvU3Vuti0f0+LLI1hRZC2H5QaiQYUMurNMXEhydmzW2Wv7aLl5+AUMlInhCC2/iIdNwtvKyXFu9SuYYSyuHjxF59lT29m059xbzjLlJhrWCC1Uxj/0nYOOx3B6dVyZ1kjRBGCtjb2sxBqre+mafSv2murWMnmbMf0MF8aOx0EG0gopseCfUjzQp37ljtzJ/k2dXU01hgtw3VKpnTzKqWOJG66F2zkaUXCBFeuq8YF5rN/X1Qu3isA==" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:09 volumio go-librespot[23022]: time="2025-12-10T16:57:09-06:00" level=debug msg="completed challenge" Dec 10 16:57:10 volumio go-librespot[23022]: time="2025-12-10T16:57: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 " Dec 10 16:57:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:11 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:11 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Dec 10 16:57:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:13 volumio go-librespot[23044]: go-librespot daemon starting... Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="app state loaded" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57: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]" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57: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]" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57: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]" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=info msg="zeroconf server listening on port 43953" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="obtained new client token: AABiS+vMcdPtn3o6g+loDmH6VYjF//CB4Q9tQPkJXFrlhymDb5iGQ9+V8taxxm1cRSFPf8Rw1udvLfjcLWwCzQ3rbvqF4410YqhViSMcLqI79yx7dzyYwTrxW4A4jHNsr2UL9k5sEdsm84IyHGl+U493HbRMdK9tNw+UzrB5eyDpMyLzfZrvAAmO0I1kjO8q6RfHbBT7X88nuWBlfkMd30oYokgSAa7hJZqR/eoukd8bYjK1MaoD4z9Njw==" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57:13-06:00" level=debug msg="completed challenge" Dec 10 16:57:13 volumio go-librespot[23045]: time="2025-12-10T16:57: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 " Dec 10 16:57:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:14 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:14 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Dec 10 16:57:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:16 volumio go-librespot[23052]: go-librespot daemon starting... Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="app state loaded" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=info msg="zeroconf server listening on port 42199" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="obtained new client token: AADGL1D7SxQi9vrRTHgYaMyZN487s9JOvOLVXACrRnS1YzVt79+fwOHQWj2tlFupSiTawXzyu0wPtP9Ig5A0GkZnj6V46e11kQcp2q+bjnVqyY3LX8UmGyjQKmq2Lwuw1gsSwbmrpl4rRSWbBZ0MoKdbN4o9gOlYurh/u2hJiPSG4uz0A5QGs8N2xZ9VcUjtMrqSdSNw+2rAD9KztUMNiNytZYJa6SJnrQnv055YJSjfsjNptqi80P3BeQ==" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57:17-06:00" level=debug msg="completed challenge" Dec 10 16:57:17 volumio go-librespot[23053]: time="2025-12-10T16:57: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 " Dec 10 16:57:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:17 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:17 volumio volumio[22080]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76. Dec 10 16:57:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:20 volumio go-librespot[23074]: go-librespot daemon starting... Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="app state loaded" Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:20 volumio volumio[22080]: info: Initializing connection to go-librespot Websocket Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="new websocket client" Dec 10 16:57:20 volumio volumio[22080]: info: Connection to go-librespot Websocket established Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 10 16:57:20 volumio go-librespot[23075]: time="2025-12-10T16:57:20-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57:21-06:00" level=info msg="zeroconf server listening on port 42413" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57:21-06:00" level=debug msg="obtained new client token: AADY8mW3/QKIKM1lntraVSztc8aHbzN1B8L7YjXh/ELI3ImI4gtrxMyD/7El2K4X0HNqd4tZIQB/CjhxJIZOISb2trCMhq6vGaNqMt+Om8ifh73hzJS6H3KBgLnftcuNheG4BPE7aMOHZ4uhUeq8UTaxOtPXllzh9Aov6C70eIMxcSQ7gz8f9cP/HkUWBf/JKNp3Qp3AiqfDOW1GYRn7FcyUep957fAWn2vx0xBDysrOHrslWUTrWbw=" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57:21-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57:21-06:00" level=debug msg="completed keyexchange" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57:21-06:00" level=debug msg="completed challenge" Dec 10 16:57:21 volumio go-librespot[23075]: time="2025-12-10T16:57: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 " Dec 10 16:57:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 10 16:57:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 10 16:57:21 volumio volumio[22080]: info: Connection to go-librespot Websocket closed Dec 10 16:57:23 volumio volumio[22080]: info: Getting Spotify volume Dec 10 16:57:23 volumio volumio[22080]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 16:57:23 volumio volumio[22080]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 10 16:57:23 volumio volumio[22080]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 10 16:57:23 volumio volumio[22080]: errno: -111, Dec 10 16:57:23 volumio volumio[22080]: code: 'ECONNREFUSED', Dec 10 16:57:23 volumio volumio[22080]: syscall: 'connect', Dec 10 16:57:23 volumio volumio[22080]: address: '127.0.0.1', Dec 10 16:57:23 volumio volumio[22080]: port: 9879, Dec 10 16:57:23 volumio volumio[22080]: response: undefined Dec 10 16:57:23 volumio volumio[22080]: } Dec 10 16:57:23 volumio volumio[22080]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 16:57:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Dec 10 16:57:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 10 16:57:24 volumio go-librespot[23097]: go-librespot daemon starting... Dec 10 16:57:24 volumio go-librespot[23098]: time="2025-12-10T16:57:24-06:00" level=info msg="running go-librespot 0.4.0" Dec 10 16:57:24 volumio go-librespot[23098]: time="2025-12-10T16:57:24-06:00" level=debug msg="app state loaded" Dec 10 16:57:24 volumio go-librespot[23098]: time="2025-12-10T16:57:24-06:00" level=debug msg="stored credentials not found" Dec 10 16:57:24 volumio go-librespot[23098]: time="2025-12-10T16:57:24-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 10 16:57:24 volumio sudo[23106]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-10 16:56' Dec 10 16:57:24 volumio sudo[23106]: 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"