-- Logs begin at Mon 2026-04-13 11:12:42 UTC, end at Mon 2026-04-13 13:13:36 UTC. -- Apr 13 13:12:01 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:01 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:02 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:02 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281069. Apr 13 13:12:02 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:03 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:03 neosonar go-librespot[31248]: go-librespot daemon starting... Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="app state loaded" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=info msg="zeroconf server listening on port 41283" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="obtained new client token: AADSzCi6QwZh+J5+ltTXkqWBjUYAb2sBchOHGxkFtoTAr7k+/lddx+Nmrljt1iR6JonBtoPff/OYK53NqKqRS860KdT9mdvE2MJkCmntPnko/L0Gup+nFSj6H+b3hFZm3vl5NEbMXFb6oLI/vo6rlVmCk5Gk9eVudtZ8X03/nZJm294JOlxgeHHFnGwyJ6lIy5TYkXJuBO6FwhBsa6ytVSO5kMt+uAUrxy1JpJvvvZCzbKnEY9RlLRg2Djg=" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="completed keyexchange" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=debug msg="completed challenge" Apr 13 13:12:03 neosonar go-librespot[31248]: time="2026-04-13T13:12:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:03 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:03 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:04 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:04 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:06 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:06 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281070. Apr 13 13:12:06 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:06 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:06 neosonar go-librespot[31271]: go-librespot daemon starting... Apr 13 13:12:06 neosonar go-librespot[31271]: time="2026-04-13T13:12:06Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:06 neosonar go-librespot[31271]: time="2026-04-13T13:12:06Z" level=debug msg="app state loaded" Apr 13 13:12:06 neosonar go-librespot[31271]: time="2026-04-13T13:12:06Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=info msg="zeroconf server listening on port 39543" Apr 13 13:12:07 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="new websocket client" Apr 13 13:12:07 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="obtained new client token: AAA3VrnLU8DpBimjEjZaVD591LbCUBUsQf53J2MBbpFsghj27mGhD53F+K/zQ4wtub0aKgKGGH5YWbnPqyaBNcN+raAyCMxviWAO4PYypgHY3+OrVu6Ax1T603O8G2uVI0GdU2bDrLhDlL2FCzmxuDjFloXY+GPHJLDqpoNo0TagtUtvAJi4asl/QCw6z1iADQi40MgxJfM5+8xDvmKFOlbA3DZFt4/ZfL/oUSjIEdVJXciLj4XeEN+Z" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="completed keyexchange" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=debug msg="completed challenge" Apr 13 13:12:07 neosonar go-librespot[31271]: time="2026-04-13T13:12:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:07 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:07 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:07 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:12:10 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:12:10 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:10 neosonar volumio[962]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 13 13:12:10 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54346) Apr 13 13:12:10 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:12:10 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:12:10 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:12:10 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:12:10 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:10 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:10 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:10 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281071. Apr 13 13:12:10 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:10 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:10 neosonar go-librespot[31279]: go-librespot daemon starting... Apr 13 13:12:10 neosonar go-librespot[31279]: time="2026-04-13T13:12:10Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:10 neosonar go-librespot[31279]: time="2026-04-13T13:12:10Z" level=debug msg="app state loaded" Apr 13 13:12:10 neosonar go-librespot[31279]: time="2026-04-13T13:12:10Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=info msg="zeroconf server listening on port 35823" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="obtained new client token: AACN8phMqqtVNAz07pO47jgA+KFKuxf6LzqAUMUUzXSnWEJ8zGteMBBC3DnvwOrV6dEokj/mmDUZFVIuRsRk6LV4T9B/4QGf84e8wSDOwhE8mqTRzDsZe+1Tp4bGTFNZVjvjd9VASlcWAnbfyYjzq0Xo4U8+AMfr8TqBMAD1Ty8a3suHLIFIcTCiHYThxPmU9NoxCQnEpjEmLOKR43NX0M8A58iphSDQTBVWP1ZJFyOiUiXS/Ijh724E" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="completed keyexchange" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=debug msg="completed challenge" Apr 13 13:12:11 neosonar go-librespot[31279]: time="2026-04-13T13:12:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:11 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:11 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:13 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:13 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:14 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:14 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281072. Apr 13 13:12:14 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:14 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:14 neosonar go-librespot[31302]: go-librespot daemon starting... Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="app state loaded" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=info msg="zeroconf server listening on port 41021" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="obtained new client token: AACFCWeVoHxK+LoH5FWCh914Z3FcN7GmEOaKzac0653whQLsaX/E6CoayISF7iK1OKnvgNttnJQmPXY2XkEySoHhgexgzwslQWBTjl3zpHPavU0ltfNZdHxrfSyIWLSeUQjhDlikU3DaoMdxUUfiAFWUdLnIPmAOvsgwqltubZSiuXong/wUNunoidNcLWMvSNmGh2knMWUgDwBazEk1IjEavUG9PjixrIrDt165jRSnxn1994rNFXqXIeY=" Apr 13 13:12:14 neosonar go-librespot[31302]: time="2026-04-13T13:12:14Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:15 neosonar go-librespot[31302]: time="2026-04-13T13:12:15Z" level=debug msg="completed keyexchange" Apr 13 13:12:15 neosonar go-librespot[31302]: time="2026-04-13T13:12:15Z" level=debug msg="completed challenge" Apr 13 13:12:15 neosonar go-librespot[31302]: time="2026-04-13T13:12:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:15 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:15 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:16 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:16 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:18 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:18 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281073. Apr 13 13:12:18 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:18 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:18 neosonar go-librespot[31348]: go-librespot daemon starting... Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="app state loaded" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=info msg="zeroconf server listening on port 35935" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="obtained new client token: AAA2s+jTDjMKWb4HK8BXBj8QQtaHarsbzgI95V1YrQgiVrDUaBjnjRzXXUAK2mnZYKXW5R5l/uPhRWY1o1JjY3x4vjvacX1oPc2tu0s+XvZVhc8QE3Qs0nqFrCVnwRMLgGEMrN6ljo9ChQOKqB1hT1OI2jH8MVxB9kNXFOCtntWU3GxSh0q3bgBF0sY8KX4Uurcffvyhh+pqMA3jkxwNBLld+o6a9yEtD83JbTXCX5h+o8D96RhOyFMN1QE=" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="completed keyexchange" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=debug msg="completed challenge" Apr 13 13:12:18 neosonar go-librespot[31348]: time="2026-04-13T13:12:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:18 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:18 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:19 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:19 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:21 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:21 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281074. Apr 13 13:12:21 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:21 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:21 neosonar go-librespot[31356]: go-librespot daemon starting... Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="app state loaded" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=info msg="zeroconf server listening on port 40225" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="obtained new client token: AADZ07lBe17XZZ5XiH8nxqIbENOia2AMudAjVwzwmavCChQ043s7uEQOz5q5KWnx8KbVc33KJIomHDG+aHw3sYI5alLBiV+FstQ4DHskspiPKT3YNQ81lGGVnu557yUMohg+4vPImJWqt9Sp7E50G5lo9bonLelxJpAj7zHsMfTv0/aZxTRuWPf3ItbYG40MI6sQOINHY5h9TqW0/X/gRdAnnBPnrnmlQGRYICf+fAA5HUFbVgsEErUW4IA=" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:22 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="new websocket client" Apr 13 13:12:22 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="completed keyexchange" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=debug msg="completed challenge" Apr 13 13:12:22 neosonar go-librespot[31356]: time="2026-04-13T13:12:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:22 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:12:22 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:22 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:25 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:12:25 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:25 neosonar volumio[962]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 13 13:12:25 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54347) Apr 13 13:12:25 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:12:25 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:12:25 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:12:25 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:12:25 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:25 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:25 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:25 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281075. Apr 13 13:12:25 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:25 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:25 neosonar go-librespot[31379]: go-librespot daemon starting... Apr 13 13:12:25 neosonar go-librespot[31379]: time="2026-04-13T13:12:25Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:25 neosonar go-librespot[31379]: time="2026-04-13T13:12:25Z" level=debug msg="app state loaded" Apr 13 13:12:25 neosonar go-librespot[31379]: time="2026-04-13T13:12:25Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=info msg="zeroconf server listening on port 37335" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="obtained new client token: AAAHCFb/5/tBp5GMKc1uaJrxUnJoXJ84+GmkeTkug40c4vuDbTnbUiszJnigbuzd55SYEZ0RY+/fVKF+sYdpV2fCTJUyyu5qdnHtPoGdXuiZlIq+UXc+NfUvaV66a1MEQE4PdAv69XCCXCux20WdYS28mPATmS7BoHf4RDrnckaKEgK4PITN1vvGq70OoHsnakAh6kqRHNZPXLsUBSZFO+/Hx7DV/3daOS5AwNnZ2A04G35yCetYEkeB" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="completed keyexchange" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=debug msg="completed challenge" Apr 13 13:12:26 neosonar go-librespot[31379]: time="2026-04-13T13:12:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:26 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:26 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:28 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:28 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:29 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:29 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281076. Apr 13 13:12:29 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:29 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:29 neosonar go-librespot[31387]: go-librespot daemon starting... Apr 13 13:12:29 neosonar go-librespot[31387]: time="2026-04-13T13:12:29Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:29 neosonar go-librespot[31387]: time="2026-04-13T13:12:29Z" level=debug msg="app state loaded" Apr 13 13:12:29 neosonar go-librespot[31387]: time="2026-04-13T13:12:29Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=info msg="zeroconf server listening on port 42741" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="obtained new client token: AADY4q2Xe9+/Y+pCiE2s0SJZhEZndAg/4LtUr1evv9RKqOzb3XJeUb5eQu21wBG2HT/Ou2UFPgM6VxmnKQvDgCzSaUsYOIXggYxcrXnP+FCcXwXYfU1oye+j7R1xaEYv2B8WHrccOxdNHEDFsMNkcm+9knE7BqZskswZXm2ZqoOnueRdhlNPkjC948rqykNGr1+4pAmil1eJGXkheNdybCfzMEof/rbVtWAPBK22TTdOSMKPBH+Maaub" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="completed keyexchange" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=debug msg="completed challenge" Apr 13 13:12:30 neosonar go-librespot[31387]: time="2026-04-13T13:12:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:30 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:30 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:31 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:31 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:33 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:33 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281077. Apr 13 13:12:33 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:33 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:33 neosonar go-librespot[31395]: go-librespot daemon starting... Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=debug msg="app state loaded" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=info msg="zeroconf server listening on port 44037" Apr 13 13:12:33 neosonar go-librespot[31395]: time="2026-04-13T13:12:33Z" level=debug msg="obtained new client token: AABiccQphlQMADjr+ASsLNe/boXligpoFS40mqAahTaBRvi7c4IXn24wMa/NukQIdXjqgFWIMxCzr1z3SJCfHf4F8dt0PowOi2t1WmbMMw83wvIeOfSkQUBmFHD7Lpo4P/kUI9cW5Pm5PSacxSEHCb7YnNmOKsh2ICpyk7+zr8hh7KX+Ii2YAQy1g27lWlFIBSet/frItjPzi4X4mILLC3+CTIdzd+IpFPDRVkTFoBfcJq2spRS+QUdrgiE=" Apr 13 13:12:34 neosonar go-librespot[31395]: time="2026-04-13T13:12:34Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:34 neosonar go-librespot[31395]: time="2026-04-13T13:12:34Z" level=debug msg="completed keyexchange" Apr 13 13:12:34 neosonar go-librespot[31395]: time="2026-04-13T13:12:34Z" level=debug msg="completed challenge" Apr 13 13:12:34 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:34 neosonar go-librespot[31395]: time="2026-04-13T13:12:34Z" level=debug msg="new websocket client" Apr 13 13:12:34 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:12:34 neosonar go-librespot[31395]: time="2026-04-13T13:12:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:34 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:34 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:34 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:12:37 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:12:37 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:37 neosonar volumio[962]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 13 13:12:37 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54348) Apr 13 13:12:37 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:12:37 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:12:37 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:12:37 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:12:37 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:37 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:37 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:37 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281078. Apr 13 13:12:37 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:37 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:37 neosonar go-librespot[31417]: go-librespot daemon starting... Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="app state loaded" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=info msg="zeroconf server listening on port 35783" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="obtained new client token: AAC9mpo/ThPrMEoQGMDn9YBL1G0F5BhGjWGMb58bjXHCGMJs9gzX4+M5M1tpExvd+XHcOjVEFxLaH2SxXfsksywUHCshyLMwreM5rNsCELyHtcuP9zJrAJe1ONmprlgC4xn3rJ/57xIuwh5TFOvIVzBCBLSAvYtphwt+nDbzC7cvLoCB2YfM9kQbYzstPLB4gItt3maZHD6MdjC+JuERCH/1ScBJ4UJ0x/KHcyW3E9bEJTe9sK2oa4WXWNg=" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="completed keyexchange" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=debug msg="completed challenge" Apr 13 13:12:38 neosonar go-librespot[31417]: time="2026-04-13T13:12:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:38 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:38 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:40 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:40 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:41 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:41 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281079. Apr 13 13:12:41 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:41 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:41 neosonar go-librespot[31425]: go-librespot daemon starting... Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="app state loaded" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=info msg="zeroconf server listening on port 35841" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="obtained new client token: AAAYlYCQK4ybDF2bds6LRdJXWv2KPiPWTYCx4Z958TchZw7IZGy6/TNz0z6m1SGlMkd0WxX98Dp/fFJe61kF0hH7YaUbVTHiynM/zOBgsq3HrP4hc0aYdIo7pLFYGsvXYetBnqK1yVNvpeqjTbD4DUL7k+2+ist6WaI/zpvXJzAnBXOJvcUbxJPRm/FShiXK+KnjPzv8v7w9QmwYPt2YKTgL/fVr4FKHzk8mAIzxzeoDsXJyHsbw3cX3Si4=" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="completed keyexchange" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=debug msg="completed challenge" Apr 13 13:12:42 neosonar go-librespot[31425]: time="2026-04-13T13:12:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:42 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:42 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:43 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:43 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:45 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:45 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281080. Apr 13 13:12:45 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:46 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:46 neosonar go-librespot[31448]: go-librespot daemon starting... Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="app state loaded" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=info msg="zeroconf server listening on port 38103" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="obtained new client token: AACv/69TS+Xn/FThBzXs652/ldizR9dLsh8YTYWCLYzUruzUgFgq9Y5rhkvOTw/kzybXlNfkz8XzJqZomeVSwBYLfQ0hf//NBkveJh5mMMqNH+CyAUtGKp8d+lJQwAncZUscLn3284Mkh3PBq8jZ+9EWYrw050iygix4HG12qJKkTXsTamxwjequLcP0fy5Ue03xZlcwuuiMQMLgv4/ZcIBn5J9ygdiF2WyZNgehpvmuHz7eoxsgeV1aRkk=" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="completed keyexchange" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=debug msg="completed challenge" Apr 13 13:12:46 neosonar go-librespot[31448]: time="2026-04-13T13:12:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:46 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:46 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:46 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:46 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:49 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:49 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281081. Apr 13 13:12:49 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:49 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:49 neosonar go-librespot[31456]: go-librespot daemon starting... Apr 13 13:12:49 neosonar go-librespot[31456]: time="2026-04-13T13:12:49Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:49 neosonar go-librespot[31456]: time="2026-04-13T13:12:49Z" level=debug msg="app state loaded" Apr 13 13:12:49 neosonar go-librespot[31456]: time="2026-04-13T13:12:49Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:49 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:49 neosonar go-librespot[31456]: time="2026-04-13T13:12:49Z" level=debug msg="new websocket client" Apr 13 13:12:49 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=info msg="zeroconf server listening on port 37095" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="obtained new client token: AAA2CS/kPktqAGHmD4JavdrSofqg9xdjEsTYCJzSAsA4UfaTARy2fhyObeoZQVtiXw6WGrzkfj2DgCQPkc1V+NhDHRhbnsQS0oNjzSsqGEBY27dqkvuyDEa81ZFhlXFaYyHMWFT+28YLsElHFFYCFBck1GQtcLNIGi9nATpLA93JqU0mc+MX29NaN05J1c6Uj17QGZXvgJQu73oLefdwJGQPJW9IzeuqLrNvn11kzUWcRzN/AHWWnd2y" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="completed keyexchange" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=debug msg="completed challenge" Apr 13 13:12:50 neosonar go-librespot[31456]: time="2026-04-13T13:12:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:50 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:12:50 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:50 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:52 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:12:52 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:52 neosonar volumio[962]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 13 13:12:52 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54349) Apr 13 13:12:52 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:12:52 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:12:52 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:12:52 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:12:53 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:53 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:53 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:53 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281082. Apr 13 13:12:53 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:53 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:53 neosonar go-librespot[31464]: go-librespot daemon starting... Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=debug msg="app state loaded" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=info msg="zeroconf server listening on port 39855" Apr 13 13:12:53 neosonar go-librespot[31464]: time="2026-04-13T13:12:53Z" level=debug msg="obtained new client token: AADfCxKVKJ8wadZKcvX8VT9K0blEopBX5eR+/FyfGBbwB5LbK/FKl5Gh4Ykc6AqpZaEY0uTaksiwM8Prd/zFavmBTuMPdjxa5HulABtJ52XiPvc6fu+dK8WbyAS1kQKjsidlTJBot3dmCeYFnX8kIqrkbjNVW4gOfhKy79dHBuoDOVqYwWin9WYirhEtfo7D8NKx5RgbHUFPy6XvfKkb2p3jHd9ve+ZqOY0V6zgzeavSbaNW8CCxtddjzkc=" Apr 13 13:12:54 neosonar go-librespot[31464]: time="2026-04-13T13:12:54Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:54 neosonar go-librespot[31464]: time="2026-04-13T13:12:54Z" level=debug msg="completed keyexchange" Apr 13 13:12:54 neosonar go-librespot[31464]: time="2026-04-13T13:12:54Z" level=debug msg="completed challenge" Apr 13 13:12:54 neosonar go-librespot[31464]: time="2026-04-13T13:12:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:54 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:54 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:56 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:56 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:12:57 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:12:57 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281083. Apr 13 13:12:57 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:12:57 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:12:57 neosonar go-librespot[31487]: go-librespot daemon starting... Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=debug msg="app state loaded" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=info msg="zeroconf server listening on port 32853" Apr 13 13:12:57 neosonar go-librespot[31487]: time="2026-04-13T13:12:57Z" level=debug msg="obtained new client token: AADXMZu5yGXBDg6/Zfhkx5sEwHS4xK11QBzEDxheqta2v5w+54tCoKti7aa7G088HnAujnXFCmrNo8czqj6Ix0PIbM6VAYmoIVquYe6trbrAGdNJHds5mXya21K2/Uyo8+gDyqrQXK9bYsNYdTBOBKKN6jWdsUuIp9EDqDX9QixSRq6UVzSaLLFTsMRos5UhtKLUQENQd4klhDrfbm4X3pDL4c5zOcmtQOsPNtY5D2ql/RM4s4vuyhh/yrg=" Apr 13 13:12:58 neosonar go-librespot[31487]: time="2026-04-13T13:12:58Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:12:58 neosonar go-librespot[31487]: time="2026-04-13T13:12:58Z" level=debug msg="completed keyexchange" Apr 13 13:12:58 neosonar go-librespot[31487]: time="2026-04-13T13:12:58Z" level=debug msg="completed challenge" Apr 13 13:12:58 neosonar go-librespot[31487]: time="2026-04-13T13:12:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:12:58 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:12:58 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:12:59 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:12:59 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:01 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:01 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281084. Apr 13 13:13:01 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:01 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:01 neosonar go-librespot[31495]: go-librespot daemon starting... Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="app state loaded" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=info msg="zeroconf server listening on port 42697" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="obtained new client token: AACnX8BmavharZyDqZwtZk/L+HBYCPSHIp9ZkBGtNCvg7DgCYPNTgoWaqJxgywYCSNaE625lCbF2cgx9HYwpf8pxjmraZSgYltAYu4uPGEFI7qkpky2W9wO8nGXTlfMUHLRugO0G+48epPhXbSVuA58PLeCQBAhPo3LQSA668AS7DtwB4PrJ6rMLhVVnmhjEVkPqRl9BFzB2Vp7q10sGLNyHi/Vd15b+uwOdObjO05OPvD+5QksEffWOy6E=" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="completed keyexchange" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=debug msg="completed challenge" Apr 13 13:13:01 neosonar go-librespot[31495]: time="2026-04-13T13:13:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:01 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:01 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:02 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:02 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:05 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:05 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281085. Apr 13 13:13:05 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:05 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:05 neosonar go-librespot[31518]: go-librespot daemon starting... Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="app state loaded" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:05 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="new websocket client" Apr 13 13:13:05 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=info msg="zeroconf server listening on port 33935" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="obtained new client token: AABGCYZrK+sPrstmQgCHOgYL50CjXwUkMT600gCxh1v098xg/ASIzssjon/rN4HTUCH1jotMIu0/I1E2E3Q4dDegdPrPIANqHWJr1R2I7ack5QA1EJho6nnpSfjSTvXo4qYOrRKtsB5KRa87XkGxxH9Dau2p4eZGuZDc2dqvPGjGkzjmOdp1jDXFQZNykBs+bQeYgkloGOPGECZYDAThz61GDcKDUq1ssWn6QZWgwHE0jpZMfqz9q9c1YGc=" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="completed keyexchange" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=debug msg="completed challenge" Apr 13 13:13:05 neosonar go-librespot[31518]: time="2026-04-13T13:13:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:05 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:05 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:05 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:13:08 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:13:08 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:08 neosonar volumio[962]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 13 13:13:08 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54350) Apr 13 13:13:08 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:13:08 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:13:08 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:13:08 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:13:08 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:08 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:08 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:08 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281086. Apr 13 13:13:08 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:09 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:09 neosonar go-librespot[31526]: go-librespot daemon starting... Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="app state loaded" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=info msg="zeroconf server listening on port 40053" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="obtained new client token: AABhdhtTAgd9gBLhX5TKuCK1l8Qb/NWrT+zWJHf/PLZ9d6mH0PERjbr+e01HiYK6vvDG4O074u3k3TG8Ef5ZDCFyA2KCRFaklrGDTb/Teh6wlq5UFZ4C6mGbFk8EW/UVYYzsTkZAZgTBWyvobSADTBHOTIofk+Zp7jmsKa0Eu0ZjSplD6hH9royJ1Bo4cIJlDbuY+RuNJRceSwspDleW7tc95KjSUpOPP1tERrU/v4tPSjHdPj2Zj9huJWA=" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="completed keyexchange" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=debug msg="completed challenge" Apr 13 13:13:09 neosonar go-librespot[31526]: time="2026-04-13T13:13:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:09 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:09 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:11 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:11 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:12 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:12 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281087. Apr 13 13:13:12 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:12 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:12 neosonar go-librespot[31534]: go-librespot daemon starting... Apr 13 13:13:12 neosonar go-librespot[31534]: time="2026-04-13T13:13:12Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:12 neosonar go-librespot[31534]: time="2026-04-13T13:13:12Z" level=debug msg="app state loaded" Apr 13 13:13:12 neosonar go-librespot[31534]: time="2026-04-13T13:13:12Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:13 neosonar go-librespot[31534]: time="2026-04-13T13:13:13Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:13:13 neosonar go-librespot[31534]: time="2026-04-13T13:13:13Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:13:13 neosonar go-librespot[31534]: time="2026-04-13T13:13:13Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:13:13 neosonar go-librespot[31534]: time="2026-04-13T13:13:13Z" level=info msg="zeroconf server listening on port 38797" Apr 13 13:13:14 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:14 neosonar go-librespot[31534]: time="2026-04-13T13:13:14Z" level=debug msg="new websocket client" Apr 13 13:13:14 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:13:17 neosonar volumio[962]: info: Getting Spotify volume Apr 13 13:13:17 neosonar volumio[962]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 13:13:17 neosonar volumio[962]: info: CoreCommandRouter::volumioGetState Apr 13 13:13:17 neosonar volumio[962]: info: CorePlayQueue::getTrack 0 Apr 13 13:13:17 neosonar volumio[962]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 13 13:13:18 neosonar go-librespot[31534]: time="2026-04-13T13:13:18Z" level=debug msg="obtained new client token: AAAruoFhkZIWoLOQOhkDxUg6+bhTiTTfbResSqXj603nhW0hfX6TlMOsbVbFGtnLUf1FsvyzMROBvngpq5V2QofpYFsoRhg1NNV9uiZu8KnA1BKskbI4vvAKG3X0Xd56zhIfshPAEZGjGPFVqrGmxe7Mef9Kq2Aek0T3aOQPgRjgdSqvtm136ONXci+WLv9S7wiDTBrFlXesVaefZFJZh9YES9EzxQL8EBCAeY8nWtM3QkQJ1OTydFoD" Apr 13 13:13:18 neosonar go-librespot[31534]: time="2026-04-13T13:13:18Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:18 neosonar go-librespot[31534]: time="2026-04-13T13:13:18Z" level=debug msg="completed keyexchange" Apr 13 13:13:18 neosonar go-librespot[31534]: time="2026-04-13T13:13:18Z" level=debug msg="completed challenge" Apr 13 13:13:18 neosonar go-librespot[31534]: time="2026-04-13T13:13:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:18 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:18 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:18 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Error: socket hang up Apr 13 13:13:18 neosonar volumio[962]: at connResetException (internal/errors.js:607:14) Apr 13 13:13:18 neosonar volumio[962]: at Socket.socketOnEnd (_http_client.js:493:23) Apr 13 13:13:18 neosonar volumio[962]: at Socket.emit (events.js:327:22) Apr 13 13:13:18 neosonar volumio[962]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 13 13:13:18 neosonar volumio[962]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 13 13:13:18 neosonar volumio[962]: (node:962) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 54351) Apr 13 13:13:18 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:13:21 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:21 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:21 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:21 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281088. Apr 13 13:13:21 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:21 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:21 neosonar go-librespot[31594]: go-librespot daemon starting... Apr 13 13:13:21 neosonar go-librespot[31594]: time="2026-04-13T13:13:21Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:21 neosonar go-librespot[31594]: time="2026-04-13T13:13:21Z" level=debug msg="app state loaded" Apr 13 13:13:21 neosonar go-librespot[31594]: time="2026-04-13T13:13:21Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=info msg="zeroconf server listening on port 37149" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="obtained new client token: AAD2DGaVXcFNa+tAHaN32Rt05eyIOlfs2BCdsFxipcBTMMJ5jkSTHzTmqB8fVBSsVD+Ob20diThLs0YxSVVGes0CgvHF9zsMiX0wVVuNZztYHqGH6sF4AW7+NF9OjGHglB8ISTZRu7+Eh8IsKPx75nwm8ebBRgmETRCS00xyda9gA7m4TVkIQArfcwNzsNf+Y+yykyrw38XaPnpktXJwpoB7FRSVyMaj7FEInbQcrPwo2V/T+qysfj19" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="completed keyexchange" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=debug msg="completed challenge" Apr 13 13:13:22 neosonar go-librespot[31594]: time="2026-04-13T13:13:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:22 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:22 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:24 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:24 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:25 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:25 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281089. Apr 13 13:13:25 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:25 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:25 neosonar go-librespot[31617]: go-librespot daemon starting... Apr 13 13:13:25 neosonar go-librespot[31617]: time="2026-04-13T13:13:25Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:25 neosonar go-librespot[31617]: time="2026-04-13T13:13:25Z" level=debug msg="app state loaded" Apr 13 13:13:25 neosonar go-librespot[31617]: time="2026-04-13T13:13:25Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=info msg="zeroconf server listening on port 42561" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="obtained new client token: AAAaCdJp5JdRN0zZo9Hwi0DriTt7pxmF8xuvvW/iwZbQXFBprDoPyG0AyWYlUsk4l+/jWHsscE5FtB22Opo4RQdWkd2/GP2xkTPHu/DZJ3fz9YS8+HLr3Oy+6yUF2kk5vk8TBKaKk8xgiln1ZLWFJRoqh5JPDzYBZdxFSO8NX23BUXUACXb0HViCTMA0Wy0wiCEiKVHvYkHVnnVf0icflVA6n+uQLSnpYc17EcjlzdrCvYlEry270N1P" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="completed keyexchange" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=debug msg="completed challenge" Apr 13 13:13:26 neosonar go-librespot[31617]: time="2026-04-13T13:13:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:26 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:26 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:27 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:27 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:29 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:29 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281090. Apr 13 13:13:29 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:29 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:29 neosonar go-librespot[31625]: go-librespot daemon starting... Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="app state loaded" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=info msg="zeroconf server listening on port 45179" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="obtained new client token: AAAVR5DRzV+XElVgAJijXmp8NBYbJAWK/muB0Mo5rs6h5K1jgdrf+qXIuixtH170PqhDD7UkR+kybVpc/jh55oV1i6YM/mLs1KEBW2kT2v0+nSKbY5b2TXKbI0+4QMov74BdIgf82jL3yb8x72WQ8QP72//wdbvOl0BUKPrBZ7RoYyoake8b/APDQR2p1z+wGR3F0FRhSsv1ZiAyo/ryqYJdqMBulvoAyCT0AinL+By5B+5povNmb8eZUpU=" Apr 13 13:13:29 neosonar go-librespot[31625]: time="2026-04-13T13:13:29Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:30 neosonar go-librespot[31625]: time="2026-04-13T13:13:30Z" level=debug msg="completed keyexchange" Apr 13 13:13:30 neosonar go-librespot[31625]: time="2026-04-13T13:13:30Z" level=debug msg="completed challenge" Apr 13 13:13:30 neosonar go-librespot[31625]: time="2026-04-13T13:13:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:30 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:30 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:30 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:30 neosonar volumio[962]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 13 13:13:33 neosonar systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 13 13:13:33 neosonar systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 281091. Apr 13 13:13:33 neosonar systemd[1]: Stopped go-librespot Daemon. Apr 13 13:13:33 neosonar systemd[1]: Started go-librespot Daemon. Apr 13 13:13:33 neosonar go-librespot[31633]: go-librespot daemon starting... Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=info msg="running go-librespot 0.2.0" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="app state loaded" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 13:13:33 neosonar volumio[962]: info: Initializing connection to go-librespot Websocket Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="new websocket client" Apr 13 13:13:33 neosonar volumio[962]: info: Connection to go-librespot Websocket established Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=info msg="zeroconf server listening on port 36253" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="obtained new client token: AAD4pk76YnaYGkv5C7rc803/rDFqiZbjexdBOc0TWXMJzbJgQktB4ZtDXbf7bR4inTScidH17GOR18HW3WK4m+0jhdpICpRsOtzopCPp++LUGB1cfgbsgmDgnKqWLyo28iJFi74WJrQfErxkaCvuFVb//lx5Xc89qyK+nxlRL+z7RWjzoezv7ddvZGyd8lxdvgZPuANI/J52gcu9unqkfkhWpv7r0bgGQrFvkwIxJYZO2gZixXN9xVCbnTI=" Apr 13 13:13:33 neosonar go-librespot[31633]: time="2026-04-13T13:13:33Z" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 13 13:13:34 neosonar go-librespot[31633]: time="2026-04-13T13:13:34Z" level=debug msg="completed keyexchange" Apr 13 13:13:34 neosonar go-librespot[31633]: time="2026-04-13T13:13:34Z" level=debug msg="completed challenge" Apr 13 13:13:34 neosonar go-librespot[31633]: time="2026-04-13T13:13:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Apr 13 13:13:34 neosonar systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 13 13:13:34 neosonar systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 13 13:13:34 neosonar volumio[962]: info: Connection to go-librespot Websocket closed Apr 13 13:13:36 neosonar volumio[962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 13:13:36 neosonar volumio[962]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Apr 13 13:13:36 neosonar volumio[962]: code: 'auth/network-request-failed', Apr 13 13:13:36 neosonar volumio[962]: a: null Apr 13 13:13:36 neosonar volumio[962]: } Apr 13 13:13:36 neosonar volumio[962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 13:13:36 neosonar sudo[31664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-13 13:12 Apr 13 13:13:36 neosonar sudo[31664]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"