Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=info msg="zeroconf server listening on port 44273" Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=debug msg="obtained new client token: AADci/pVKiETjWhPQl6yvSnqzSX2bKuHCis/1Ts4JwYBDQUM1BaeA91qFJgjHi0fMqAk5sM5vN4FaYlrAK3KMlN5O6/oVvqCJVmToK64IqGut6IAK/0pmVlxos2rMmuXmugCCXJFJbTcAFaOr897j4h5RAE3QJCzHU+Fz0ZX2x91LL6cR0FsvLDIR8IlWsoYwLm2AWZetKa7wQTEGpS9hXw9hVu5IHfsGF27qj1ahCgOUsgygjo5du0=" Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=debug msg="completed challenge" Dec 08 05:03:00 volumio go-librespot[19442]: time="2025-12-08T05:03:00-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Dec 08 05:03:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:00 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:00 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::volumioGetBrowseSources Dec 08 05:03:03 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 08 05:03:03 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:03 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39. Dec 08 05:03:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:03 volumio go-librespot[19463]: go-librespot daemon starting... Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=debug msg="app state loaded" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-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 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-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 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=info msg="zeroconf server listening on port 36823" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=debug msg="obtained new client token: AAAh+BSDqo7pG3aPHrhwAdt/GyBaDDUunKO0FTDhVraAWZrWzf8bmOfOA6Ey1WyGh/Yw/Ja2N/ftn/4b3An6yE5OdLpGjX1rscqNdGj5YHcAQ+ZoVT+KYoQ7X46NCkTAzNZtalzHovNSLR2xxKos8R8gmKw8iTJ7mnvP/oMGoPyA2bXS5CrrlTm1npvmS51PKWCS6X+w4rWXLtQSfmw/8mpXpOPLt1cEKm7oxili0Kb2w3Xgoz3D/kGH6A==" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03: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" Dec 08 05:03:03 volumio go-librespot[19464]: time="2025-12-08T05:03:03-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Dec 08 05:03:04 volumio go-librespot[19464]: time="2025-12-08T05:03:04-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:04 volumio go-librespot[19464]: time="2025-12-08T05:03:04-06:00" level=debug msg="completed challenge" Dec 08 05:03:04 volumio go-librespot[19464]: time="2025-12-08T05:03:04-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Dec 08 05:03:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:04 volumio volumio[18836]: error: MyVolumio Plugin failed to authenticate in a timely fashion Dec 08 05:03:04 volumio volumio[18836]: info: Completed starting MyVolumio Plugin Dec 08 05:03:04 volumio volumio[18836]: [Metrics] CommandRouter: 54s 104.48ms Dec 08 05:03:04 volumio volumio[18836]: info: CoreCommandRouter::volumiosetStartupVolume Dec 08 05:03:04 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 05:03:04 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 05:03:04 volumio volumio[18836]: info: CoreCommandRouter::Close All Modals sent Dec 08 05:03:04 volumio volumio[18836]: info: CoreCommandRouter::Close All Modals sent Dec 08 05:03:05 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 08 05:03:05 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 08 05:03:05 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 08 05:03:06 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:06 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40. Dec 08 05:03:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:07 volumio go-librespot[19477]: go-librespot daemon starting... Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="app state loaded" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-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 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-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 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=info msg="zeroconf server listening on port 42825" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="obtained new client token: AADBrn5GB4sfasoe78N+9lYo8/IMAfGNjV4NtGcdqgtdpV7Pd7t3cUx/5gCfv7G2pqhm/0zkrfvITlqHT6wj3X7S7/kgYJxm3VtdlgCnwMVf2fmInrvnJN0AB3mTt8a/Ig0GSE6EXVKdGWx9DoeODSXCIZPCt6SE3cR2LdVF9LpXsWAC8N8hQ65sEl+m3NIOIrsMs6UQIeNsW5WGdkU0vJiqJV3ue41LSrxb6DWnG0ys/eAG40/EvgFu2w==" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03: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" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-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" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="connected to ap-guc3.spotify.com:80" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03:07-06:00" level=debug msg="completed challenge" Dec 08 05:03:07 volumio go-librespot[19478]: time="2025-12-08T05:03: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 " Dec 08 05:03:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:09 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:09 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41. Dec 08 05:03:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:10 volumio go-librespot[19485]: go-librespot daemon starting... Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="app state loaded" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=info msg="zeroconf server listening on port 44649" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="obtained new client token: AAAcuFZX8hVEiU77IzaqFJ0bKjuQe62rllUshaZNgIbLmf+sWONZ5IxWRdtlsZn4Ji1j+vcIotX9l+cVlys9AGKtsJUX0P6MMvdOW+7mLoG7uP0oE2ZiUt90w740tY5XC5xehPKmlKSwBYksSjIv8oaCAX6/WuLwkhk3emh97WRiGOLz3KJMdEGBjmo7dpbldFXn+daHYB+E031at0MMbUh+ToywS6jMAeMOeqYhcShJ0jXeqGNXf+gMEQ==" Dec 08 05:03:11 volumio volumio[18836]: info: BOOT COMPLETED Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03:11-06:00" level=debug msg="completed challenge" Dec 08 05:03:11 volumio go-librespot[19486]: time="2025-12-08T05:03: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 " Dec 08 05:03:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:12 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:12 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42. Dec 08 05:03:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:14 volumio go-librespot[19510]: go-librespot daemon starting... Dec 08 05:03:14 volumio go-librespot[19511]: time="2025-12-08T05:03:14-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:14 volumio go-librespot[19511]: time="2025-12-08T05:03:14-06:00" level=debug msg="app state loaded" Dec 08 05:03:14 volumio go-librespot[19511]: time="2025-12-08T05:03:14-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:14 volumio go-librespot[19511]: time="2025-12-08T05:03:14-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-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 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-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 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-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 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-06:00" level=info msg="zeroconf server listening on port 41717" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-06:00" level=debug msg="obtained new client token: AAD7ZCu9ovVXe2Qg6tmK+I+NbwKiZXdhMIpqwWft8yh7OWwylKAACcsUtLiXAQcAxlKX4qt0iKFqAa6KkfFxn7fhsNlZ68JdHfAYTUkTJ5t3fYnAmTJJJOqLQ5RUwJmnOLyOKkVh4gLPMcIHpffLtDS6fW8bbgqekaxwIpoaKKKrongBTaFaW/9JIHKl4LLOpanak/zzK9RXT3d9D/hS+FIIoIoQwhiWV2Ml4OaCwLj9Kfpy6YTrHCg=" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-06:00" level=debug msg="completed challenge" Dec 08 05:03:15 volumio go-librespot[19511]: time="2025-12-08T05:03:15-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 08 05:03:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:15 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:15 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:18 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43. Dec 08 05:03:18 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:18 volumio go-librespot[19519]: go-librespot daemon starting... Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="app state loaded" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-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 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-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 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=info msg="zeroconf server listening on port 33157" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="obtained new client token: AACQQZUkC/34N1dLXqn8QXQFlm40mjMdN8vuuvxpCaM+sNER4fITISJiLcNl+fibH6OG8tBoaRuAEJxCxutowhSIuw2YzXz4OLdgrploxJraTDGzcJbsZzzpst+gUDcI1aJa6wzVIxrCbvmgFtlAh+hcsGlfqMMOe2sXywXCowILNfuSQLV9QbHaxaYAsrYpx/ThI2eY/CkGQ1T8AotCZz1ck8QzFyxpn5oT7NF2+ItYiuUrJwjgHmm4sA==" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:18 volumio go-librespot[19520]: time="2025-12-08T05:03:18-06:00" level=debug msg="completed challenge" Dec 08 05:03:19 volumio go-librespot[19520]: time="2025-12-08T05:03:19-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 08 05:03:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:21 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:21 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 44. Dec 08 05:03:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:22 volumio go-librespot[19528]: go-librespot daemon starting... Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="app state loaded" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03: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]" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03: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]" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03: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]" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=info msg="zeroconf server listening on port 39769" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="obtained new client token: AABmaA9CH8Uh2/Znfe3XoKlGEbIYliUVQEukPMZwXbGSRfwDbz99bXYh+dNPvSHNNIr+Gm8tMW3PuePmeBExB/SvkwMHXYti5zWODaD1e8rQmM1YOQTm6TO6hzG3bLtBdzuEj9IbiTtQu6ZOdUuarTa4q/Pw59Fm7ySakpB/Ri3F/NsN+/1lh385Wo17bq9fyrzYCH+yKhPdxwCCiHYrO52B2/ycsLgiEP5bzUW5c7V0be28WMG47sMDmA==" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03:22-06:00" level=debug msg="completed challenge" Dec 08 05:03:22 volumio go-librespot[19529]: time="2025-12-08T05:03: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 " Dec 08 05:03:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:24 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:24 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:25 volumio volumio[18836]: info: UPDATER: Scheduling automatic update Dec 08 05:03:25 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime Dec 08 05:03:25 volumio volumio[18836]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime Dec 08 05:03:25 volumio volumio[18836]: info: UPDATER: Auto update will take place at: Tue Dec 09 2025 03:14:54 GMT-0600 (Central Standard Time) Dec 08 05:03:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 45. Dec 08 05:03:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:25 volumio go-librespot[19550]: go-librespot daemon starting... Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="app state loaded" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-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 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-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 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-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 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=info msg="zeroconf server listening on port 35139" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="obtained new client token: AACt0NLOARJ+Ltz0jGg9LCTBSMwTmdt+If63dSspm6BKOuywAuDdxR7HGQX7llxztCLXq4Al0jAa8S1jzJ2F9z864sBPfdl9KPohUbAAcTXI4vYPzAQ3F8yjUq5aL3PIXGMU8uzCpg15DN0gKMco4PWff3UDcgEHXmu1SV0E4RM4pUR7bjiv8I5ZuBg5fPxlTus/lGpQscCdzrGoNNPIEzQpVb7kz2P54g4jerPADMTf98gS2wA0ak5aSg==" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-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 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="connected to ap-guc3.spotify.com:443" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03:26-06:00" level=debug msg="completed challenge" Dec 08 05:03:26 volumio go-librespot[19551]: time="2025-12-08T05:03: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 " Dec 08 05:03:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:27 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:27 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 46. Dec 08 05:03:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:29 volumio go-librespot[19558]: go-librespot daemon starting... Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-06:00" level=debug msg="app state loaded" Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03: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-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-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 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-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 08 05:03:29 volumio go-librespot[19559]: time="2025-12-08T05:03:29-06:00" level=info msg="zeroconf server listening on port 35585" Dec 08 05:03:30 volumio go-librespot[19559]: time="2025-12-08T05:03:30-06:00" level=debug msg="obtained new client token: AADbwo+FIAOG0k7fJyLUUAx68a9VY2n31RgkbcKiZRt5VGw5k8tqmB0WJbe8XyPMcc6iqQ+V1ErYvDD/d7Mq5c4M5Iet9TxGN4JT0Mu6/MjMe4odvHFjRZbvtKBoDZGPS3JeI2rhWtgo232ZccD8kq/zzyVIgEgtiYyfsUZQAv/cpAF8Z/gDfr/XhkLdZjo+BI4d1fRjk15Vze9XMzga2Y2LRYwWwY+X1aHkuAzkRPVB57oFvYGmka0=" Dec 08 05:03:30 volumio go-librespot[19559]: time="2025-12-08T05:03:30-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:30 volumio go-librespot[19559]: time="2025-12-08T05:03:30-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:30 volumio go-librespot[19559]: time="2025-12-08T05:03:30-06:00" level=debug msg="completed challenge" Dec 08 05:03:30 volumio go-librespot[19559]: time="2025-12-08T05:03:30-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 08 05:03:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:30 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:30 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 47. Dec 08 05:03:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:33 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:33 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:33 volumio go-librespot[19580]: go-librespot daemon starting... Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="app state loaded" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03: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]" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03: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]" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03: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]" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=info msg="zeroconf server listening on port 44833" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="obtained new client token: AAAWB/eoZMxOHj6vdYm+5FByqpVd8e0YlmZThZjIn9N3THUdvEnAHUCW4voeUNwoS3/jMu4DcptSam1inLsBbzQa1oln9jMdHWpudz0SOkZf3k/ZjksLbxLWp2dYQ+TXmZlYCNtZTpyiiSNmNxKr+yNviSP1VxVycOmilXW1rfyhFUPJXuE04irNEilgA0QUUefMqQWcIijYUeFH83OCtWOYaQUxbGyNGatn2fT0OA+/Wam16RKuz0kQtQ==" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03:33-06:00" level=debug msg="completed challenge" Dec 08 05:03:33 volumio go-librespot[19581]: time="2025-12-08T05:03: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 " Dec 08 05:03:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:36 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:36 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 48. Dec 08 05:03:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:37 volumio go-librespot[19591]: go-librespot daemon starting... Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="app state loaded" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03: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-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-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 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-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 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=info msg="zeroconf server listening on port 35959" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="obtained new client token: AAB6CEFfLBnl2dVMgop5V3Rj4iIQyp8vEDI1FY62iMompNCdhRyYb+pJawscwfC3rAwEGqSwI5dutpY3/Fl1KtcM94ZDzug4FZXjgQzyzylMrV6MD29hvi8GnM8i0vamITu9DvvF2KBzGRZ5Darp9JcwzX/XvYYkY1qDX5hFXxQDQqn/CXuniy+8mJcGzzKHv9tVXkulykjsy+KleDtvxkUZCxK/RXKDDD/Iv/iDd0Kki1FFqo6+sEOYqA==" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03:37-06:00" level=debug msg="completed challenge" Dec 08 05:03:37 volumio go-librespot[19592]: time="2025-12-08T05:03: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 " Dec 08 05:03:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:39 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:39 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 49. Dec 08 05:03:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:40 volumio go-librespot[19600]: go-librespot daemon starting... Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="app state loaded" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-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 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-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 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-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 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=info msg="zeroconf server listening on port 44655" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="obtained new client token: AACnMlVraSza9k9Z75Ot+1OgqzDb6BIdndM2iC+X6V4QHarvJalIGFWNgR4qh+ptlcl15psKJiqKO4rCYLDRm9bI0zILT7sDzmqXrND7v5KgHZ2k8MXfySVsIBLZnGZmxzyAmQtwX1FLkBnZ/iu/dxfQ3Odq7p/W0XsqLLUy8BZcyHeQynZYg5xtz5/V93vFlBuTtfTSUJnyWiBMeQw1Ef08htNQxBAtAzDrf4IdNkreNZwqo5GDlgjgjw==" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03:41-06:00" level=debug msg="completed challenge" Dec 08 05:03:41 volumio go-librespot[19601]: time="2025-12-08T05:03: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 " Dec 08 05:03:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:42 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:42 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 50. Dec 08 05:03:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:44 volumio go-librespot[19622]: go-librespot daemon starting... Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-06:00" level=debug msg="app state loaded" Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03: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-gew4.spotify.com:80]" Dec 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-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 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-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 08 05:03:44 volumio go-librespot[19623]: time="2025-12-08T05:03:44-06:00" level=info msg="zeroconf server listening on port 46033" Dec 08 05:03:45 volumio go-librespot[19623]: time="2025-12-08T05:03:45-06:00" level=debug msg="obtained new client token: AAAhtg57mwoUXLON7+3r5NE+gfw/me0EbDJKg9wZx4oGKYHXpV+EWC/WMDJOS6y49kxXyKF7Agbjd7Q7bhRRtaRrNjvtca+OCxuNSTR7WUJrB1uwhhQ1LBcnntW6pOTJD4AAfsH6Z8ztWMbzUHIK1ProsFcq3uiQzUAYuq1VzIWLk5xp0zJjlL+kZkfoos1Apmdvizf0yUnzwCckGqooAluPj6W/J0ScmNAWBKHYrVJirRJrEo1NMh4=" Dec 08 05:03:45 volumio go-librespot[19623]: time="2025-12-08T05:03:45-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:45 volumio go-librespot[19623]: time="2025-12-08T05:03:45-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:45 volumio go-librespot[19623]: time="2025-12-08T05:03:45-06:00" level=debug msg="completed challenge" Dec 08 05:03:45 volumio go-librespot[19623]: time="2025-12-08T05:03:45-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 08 05:03:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:45 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:45 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51. Dec 08 05:03:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:48 volumio go-librespot[19630]: go-librespot daemon starting... Dec 08 05:03:48 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:48 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="app state loaded" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-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 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-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 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=info msg="zeroconf server listening on port 43577" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="obtained new client token: AACrnQlQ7XRsKcYYQUT8tVMZ19m3MZ0tQU1eFdIXGRbPZVUXY2J5ngpcAvKq25iSt/4WhYgMIuxuAMIHs9TdDCwnak54Ymc2BVNwx0RqaOjWCgJIBeR9zQ5pV6W206euxxP8MvPJzrbLivIGv++5QUPc69/qqZzbhpBcVbAZeCnvzS4u/Um4Po4+VL7TNATQ91+Oy50rvgc2JC0zV5UYsrcE9GVSmu2k/rL2kL1nd1u53AYtnxDcwQa1xA==" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03:48-06:00" level=debug msg="completed challenge" Dec 08 05:03:48 volumio go-librespot[19631]: time="2025-12-08T05:03: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 " Dec 08 05:03:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:51 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:51 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Dec 08 05:03:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:52 volumio go-librespot[19638]: go-librespot daemon starting... Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="app state loaded" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03: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]" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03: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]" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03: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]" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=info msg="zeroconf server listening on port 34127" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="obtained new client token: AAB/V7d8ZGERbmgaq5zWNJb7hPsFnJDxKZv0SSCWEooEGEeBuXpajngTsg09uL2GnOceDa7sYALm67jVoqmPoF+SUvyvwRBPxafa6klWCl8zUz8/NqrZ6IMdjKSLsu8NUgx4YUPx/0rh7ez+RNpqX2BXpK9oJIFcgefBSU8FrFNIoQhxqGm7RApRo1NR1k0q7+SExxL9Uc0RVSyEPtAIWFeT4j+MRQD9EnXUqHzhzdIj/kfYdR0JU0rF1A==" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03:52-06:00" level=debug msg="completed challenge" Dec 08 05:03:52 volumio go-librespot[19639]: time="2025-12-08T05:03: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 " Dec 08 05:03:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:54 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:54 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Dec 08 05:03:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:55 volumio go-librespot[19663]: go-librespot daemon starting... Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="app state loaded" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-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 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-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 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-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 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=info msg="zeroconf server listening on port 42561" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="obtained new client token: AAB+VeN2IfjOviMN1Q36rfxFjpCJ16FyPda9FKUlJFTXDQtCEtpmimuzEJhJ5zymGwvfQtsCJFxW6JYcj0Krh9ygY/pXnA3sGRxNa5NmvAYTzsbCz1nCiclzDEK77M+oZ6OxMyTvIx/3Xp8p1q6I0mUVnrWIB0s8zi3BJGdfO/Ixo2/DFoMhJO7yyKsqlIuuY6tMfPRjjUKBiAc5QHgQmyG4eTa0Ex0j9sjdGspzTMtao5eVGLXP6uZcuQ==" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="completed keyexchange" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-06:00" level=debug msg="completed challenge" Dec 08 05:03:56 volumio go-librespot[19664]: time="2025-12-08T05:03:56-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 08 05:03:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:03:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:03:57 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:03:57 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:03:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Dec 08 05:03:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:03:59 volumio go-librespot[19672]: go-librespot daemon starting... Dec 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-06:00" level=debug msg="app state loaded" Dec 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-06:00" level=debug msg="stored credentials not found" Dec 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-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 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-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 08 05:03:59 volumio go-librespot[19673]: time="2025-12-08T05:03:59-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 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=info msg="zeroconf server listening on port 35249" Dec 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=debug msg="obtained new client token: AABBtuHCAytm/R4gIkFgUgVx5IzLnbDrdWxAa/G5p5QuWXLUO3HGYX6N2HO9ZFg+BEVI1yt/yg0DrZk8acNXUBnOj1LhdNH7KUd3DCoOq1o5Vd4Wa6UYi8FzfIW0tdpsOidxaMTuMNfmkqEoemAV3toUTaldnTm98QefULdbVZnhATrgiSFPAI5UKcbiuVp7uZKacFBKKg6UAFsEVer3agwmXX/kLZAHqaHJqbiGw8gKoqKtl7DFIyc=" Dec 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=debug msg="completed keyexchange" Dec 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=debug msg="completed challenge" Dec 08 05:04:00 volumio go-librespot[19673]: time="2025-12-08T05:04:00-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Dec 08 05:04:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:04:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:04:00 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:04:00 volumio volumio[18836]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:04:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Dec 08 05:04:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:04:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:04:03 volumio go-librespot[19694]: go-librespot daemon starting... Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="app state loaded" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="stored credentials not found" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:04:03 volumio volumio[18836]: info: Initializing connection to go-librespot Websocket Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="new websocket client" Dec 08 05:04:03 volumio volumio[18836]: info: Connection to go-librespot Websocket established Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-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 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-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 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=info msg="zeroconf server listening on port 44555" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="obtained new client token: AADVxUXBurQBm/z3EPjEarWItmcA29En4nPliLvWQ9va11L+pnfcn80PkkT1o0L7OT95qR9s8S0x1I4HBGzFQ1g8nx5gBHhiMoNvf/n3hO38FWaFGpFnHJ0YW4ZA2YKd4lOi2OEEcz4/WixTzKfZPvESdNx8n7eduSZQFEI7vuD11khy/DXxbtyxKPNH1Ei6FabJZ/X9H/CFDbBlEmTJOPxyfaYPxsuxYKabREZzJg+CdlDTpkLvDNCB0g==" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="completed keyexchange" Dec 08 05:04:03 volumio go-librespot[19695]: time="2025-12-08T05:04:03-06:00" level=debug msg="completed challenge" Dec 08 05:04:04 volumio go-librespot[19695]: time="2025-12-08T05:04:04-06:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " Dec 08 05:04:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 08 05:04:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 05:04:04 volumio volumio[18836]: info: Connection to go-librespot Websocket closed Dec 08 05:04:06 volumio volumio[18836]: info: Getting Spotify volume Dec 08 05:04:06 volumio volumio[18836]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 05:04:06 volumio volumio[18836]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 05:04:06 volumio volumio[18836]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 08 05:04:06 volumio volumio[18836]: errno: -111, Dec 08 05:04:06 volumio volumio[18836]: code: 'ECONNREFUSED', Dec 08 05:04:06 volumio volumio[18836]: syscall: 'connect', Dec 08 05:04:06 volumio volumio[18836]: address: '127.0.0.1', Dec 08 05:04:06 volumio volumio[18836]: port: 9879, Dec 08 05:04:06 volumio volumio[18836]: response: undefined Dec 08 05:04:06 volumio volumio[18836]: } Dec 08 05:04:06 volumio volumio[18836]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 05:04:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Dec 08 05:04:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:04:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 05:04:07 volumio go-librespot[19714]: go-librespot daemon starting... Dec 08 05:04:07 volumio go-librespot[19715]: time="2025-12-08T05:04:07-06:00" level=info msg="running go-librespot 0.4.0" Dec 08 05:04:07 volumio go-librespot[19715]: time="2025-12-08T05:04:07-06:00" level=debug msg="app state loaded" Dec 08 05:04:07 volumio go-librespot[19715]: time="2025-12-08T05:04:07-06:00" level=debug msg="stored credentials not found" Dec 08 05:04:07 volumio go-librespot[19715]: time="2025-12-08T05:04:07-06:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 05:04:07 volumio sudo[19723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-08 05:03' Dec 08 05:04:07 volumio sudo[19723]: 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"