-- Logs begin at Mon 2026-08-24 19:22:28 EDT, end at Mon 2026-08-24 21:30:17 EDT. -- Aug 24 21:29:00 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:00 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:03 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:03 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247903. Aug 24 21:29:03 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:03 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:03 muse go-librespot[3415]: Librespot-go daemon starting... Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=info msg="generated new device id: 9fce279b6f2b6b654225c25223e17887955873b0" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="obtained new client token: AAEZHiQuyTt0l7AXTYfimslnAuemzWpwZ/ySlDH3DktzsZPH9cUQIwkYXAinz7kxwPZ1SYxIOPLR1FYQoC/FCocJYD+PBobjhxafpSqtrkmovXQgSSIMCrsu1/dA1zRhawQbNI0nnPvOZLu+jg8HqGL+nofiBx4labqdt2hSinybJsTrHeZhMosCd1o4Y48PJaMJngY6czer3hb/2e8c7lfXoT4MKWoBrNTsY7g8hQjspTJVbf6Ln7VDzM0o" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="completed challenge" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:03 muse go-librespot[3415]: time="2026-08-24T21:29:03-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:03 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:03 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:03 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:03 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:04 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:04 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:06 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:06 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:07 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:07 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247904. Aug 24 21:29:07 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:07 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:07 muse go-librespot[3438]: Librespot-go daemon starting... Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=info msg="generated new device id: 063536c7f8b6e3afed5a35470e10883d742f54e3" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="obtained new client token: AAHWGh8fhMSJcUsXS6KLJULXkNVqhuf/R3IF3ZCsNOKou0IzPvjzNASvEZ6VT3O+78upjlPU6K/rwz4VgbA77swI03nJnjcPwIWMzIHD90rnDVWpjKJ+SQ3qeeG65Zicd+swpibH2BXMXWEbsLKpt5bpgXkHpZ9l1q6RZttI2nwlXgQZZrt1CW6tV021FhtbdpuWx86jUaO9WdAHe3MvJ/YYJvTn0vX1PwgaMNow5UQl6K1ol4ug61jso9Ec" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="completed challenge" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:07 muse go-librespot[3438]: time="2026-08-24T21:29:07-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:07 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:07 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:09 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:09 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:11 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:11 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247905. Aug 24 21:29:11 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:11 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:11 muse go-librespot[3487]: Librespot-go daemon starting... Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=info msg="generated new device id: f08618a7ab14edfc59deac9c8f021ac3013eff57" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="obtained new client token: AAHUfzMTsLszNgy7i3I7J1VhmWs3gdgUpBZJ/FztAO36zU0tycKKwNHDFV610K6n5fK6iL0WOqCXtYH7aaNbh0z0TJBRU4lT54aruC4E5w8MpmLr9NKFlPoN8M7P2WgYCzeQhTTv3HVPlyuoMfShl25jh9Oqe6Q/rUmb6s6VJvAoF0cxYRnlgvCJgWJddO+rCWy8CWv36RvnFIiFdwLb2Hl8xAQY9B/w55zoVaUNqAT5ZP92W0ck3NMg9Iiv" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="completed challenge" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:11 muse go-librespot[3487]: time="2026-08-24T21:29:11-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:11 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:11 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:12 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:12 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:14 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:14 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:14 muse volumio[30448]: info: Listing playlists Aug 24 21:29:14 muse volumio[30448]: info: Listing playlists Aug 24 21:29:15 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:15 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247906. Aug 24 21:29:15 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:15 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:15 muse go-librespot[3496]: Librespot-go daemon starting... Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=info msg="generated new device id: 85dbfba57bc3db1f9deac84e763f17c8c9e4b10d" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="obtained new client token: AAEy4S0nXsanr2FeYwjkF5G0bwUqyQTqH0GK1mhwo+SJlaOA0gcm0d3+47vfto/+fUZhvArI+lvnrdetjQs5/tMULhw5euHMYuFe8nXg/XjO6d1B8ihdg1JqV3sEDcKEUU2kalVlZ2+OscC357XNOkEbGyLo0GB3WEpzrbBHx8BLGmgL30pABEQXl0bJmJU6zcA64onCzAWEREKonGr1MXdY2NkqHk5DS7SUVOUM3LKlkfkLBY5hp9oPjtUt" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="completed challenge" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:15 muse go-librespot[3496]: time="2026-08-24T21:29:15-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:15 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:15 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:15 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:15 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:18 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:18 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:19 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:19 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247907. Aug 24 21:29:19 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:19 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:19 muse go-librespot[3518]: Librespot-go daemon starting... Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=info msg="generated new device id: a69a38e93636f300f70f853e897303d348d7f2e7" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="obtained new client token: AAHw/gNKT9C1pUc61qNtYNxL8d245k1gA0vLfvm+V6ukkV7FSsOotl0DBwbazN7gOjvK/GsgdnpipFjWCQmkVzz8fsvepGJfS71R9kl+Ay9Tu7H3Uvnsm0uAIdZ7fIHtuzoCEYkBiZnADIdX7C1QGMK21pA0IIWb43rffZmy9SJQpZVGMDfpqLUY5IppUuy8Q4Uvc5MsXqLn7Abamf8a6NTJg4z5KBxVMLpYd1sW3JV2qkKeXKl7l7IAH7gd" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="completed challenge" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:19 muse go-librespot[3518]: time="2026-08-24T21:29:19-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:19 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:19 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:21 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:21 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:23 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:23 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247908. Aug 24 21:29:23 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:23 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:23 muse go-librespot[3527]: Librespot-go daemon starting... Aug 24 21:29:23 muse go-librespot[3527]: time="2026-08-24T21:29:23-04:00" level=info msg="generated new device id: ed63178637375db8040e7c2afe0cca7add4760be" Aug 24 21:29:23 muse go-librespot[3527]: time="2026-08-24T21:29:23-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:23 muse go-librespot[3527]: time="2026-08-24T21:29:23-04:00" level=debug msg="obtained new client token: AAF/ZS7jBwBd+ojWRWW9pAMPrTLjRprQUudDCd2Fv7raXkL9GfmwP9Uc4gsWxpA8L+vsGlKWvGLrNgCCNZV4Y4SRZI6Xr9eUtej5eTSqhfKxTnfCiPDkj9YF+21+hu5PA/F0xFa5oAMw2QHxc99LMeQlYXdygvI2q5qF6aHjjaLCJFI6/BB0vCC9dlzgFqtk+DrAxRyncvgbXAD9Z6i+vsH8lV/JlNNdWdMv8QrCiV+CPtoOOhf0oUsaBd93" Aug 24 21:29:23 muse go-librespot[3527]: time="2026-08-24T21:29:23-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:23 muse go-librespot[3527]: time="2026-08-24T21:29:23-04:00" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.255.62:4070: connect: connection refused" Aug 24 21:29:23 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:23 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:24 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:24 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:24 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:24 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:26 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:26 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247909. Aug 24 21:29:26 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:26 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:26 muse go-librespot[3550]: Librespot-go daemon starting... Aug 24 21:29:26 muse go-librespot[3550]: time="2026-08-24T21:29:26-04:00" level=info msg="generated new device id: 4c403a6f6713c6cf7aaad16d138a4b65570b4455" Aug 24 21:29:26 muse go-librespot[3550]: time="2026-08-24T21:29:26-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:26 muse go-librespot[3550]: time="2026-08-24T21:29:26-04:00" level=debug msg="obtained new client token: AAFddYbE96ILL+F7Xje2JR65Zw4MxFR43FkVmh4CubLKugCdr4CZuMvayBgpnECpTpYpdHKyKgCVihMWFxkCn5H0Ge0NTB/XNng3X4f4orZYYVniEbUq5R38++y967vwTPy/Mn6ycncm4h/RoMDBrQgZD/hbWZtwegazlJBYDY8m8tpHsy9WX/CmCuWTCW5w8ICDG6f6+bpEVY+W+lFH7xIHLnEcV0wRkehHQU9tq6dm7rr9QJe5x/FCihUjoYs=" Aug 24 21:29:26 muse go-librespot[3550]: time="2026-08-24T21:29:26-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:26 muse go-librespot[3550]: time="2026-08-24T21:29:26-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:27 muse go-librespot[3550]: time="2026-08-24T21:29:27-04:00" level=debug msg="completed challenge" Aug 24 21:29:27 muse go-librespot[3550]: time="2026-08-24T21:29:27-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:27 muse go-librespot[3550]: time="2026-08-24T21:29:27-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:27 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:27 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:27 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:27 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:30 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:30 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247910. Aug 24 21:29:30 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:30 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:30 muse go-librespot[3558]: Librespot-go daemon starting... Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=info msg="generated new device id: cbd5721952169d8e2c919c890fe81783be93b6b4" Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=debug msg="obtained new client token: AAEB/0NzGeO22CWIA8JOF+rGcyCXRIjxb0fRgBcNQPETR0oGpYk4gh3oE2JJ4aE2WG6R030o550iLAajNv/LZq5H1EZXERFOyX4v2ahwulvho/42cw9C3kLwYwoz6xvUBhagBqIEm0hHz2pSiVbiT/8fJJbOEe/YSInhzPLsYp713x35cUWUseOeb3T15CZVZyl0iYIdj6+UTkgxUS5Jn1sVuZbC6uO5RVo6lT2Hm1td/rOu4tn+oXkiXwFMy4Q=" Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:30 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:30 muse volumio[30448]: info: Connection to go-librespot Websocket established Aug 24 21:29:30 muse go-librespot[3558]: time="2026-08-24T21:29:30-04:00" level=debug msg="new websocket client" Aug 24 21:29:31 muse go-librespot[3558]: time="2026-08-24T21:29:31-04:00" level=debug msg="completed challenge" Aug 24 21:29:31 muse go-librespot[3558]: time="2026-08-24T21:29:31-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:31 muse go-librespot[3558]: time="2026-08-24T21:29:31-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:31 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:31 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:31 muse volumio[30448]: info: Connection to go-librespot Websocket closed Aug 24 21:29:33 muse volumio[30448]: info: Getting Spotify volume Aug 24 21:29:33 muse volumio[30448]: (node:30448) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:33 muse volumio[30448]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Aug 24 21:29:33 muse volumio[30448]: (node:30448) 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: 45319) Aug 24 21:29:33 muse volumio[30448]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 24 21:29:33 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:33 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:33 muse volumio[30448]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 24 21:29:34 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:34 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:34 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:34 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247911. Aug 24 21:29:34 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:34 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:34 muse go-librespot[3566]: Librespot-go daemon starting... Aug 24 21:29:34 muse go-librespot[3566]: time="2026-08-24T21:29:34-04:00" level=info msg="generated new device id: d9df037341b6fc75a4480fe439df60f46c9c4aac" Aug 24 21:29:34 muse go-librespot[3566]: time="2026-08-24T21:29:34-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:34 muse go-librespot[3566]: time="2026-08-24T21:29:34-04:00" level=debug msg="obtained new client token: AAG8LCdE0+XX80wh9VZHvOM1jDRYTb2k8OgIH5U1Lt3Rk9C1qPVwsTkT6gBM7bg9gxqNU3icD7gEGpoymT5q7IBIwEOyq8kItoPPeNDa24iBKQm+NbD2iperN6XodpmVcIM2W9p1P7/LRtF+kFvvjnswIg9KVDaRl9jtzi9abkkjn7AH6qukFcDxz4g5kIBwjWx+ukZhJEcUs/kadbSDB7B9R2275W8Gs8QfV7sftfw895DK1ezS378n/DZEEGg=" Aug 24 21:29:34 muse go-librespot[3566]: time="2026-08-24T21:29:34-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 24 21:29:34 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:34 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:34 muse volumio[30448]: info: Listing playlists Aug 24 21:29:34 muse volumio[30448]: info: Listing playlists Aug 24 21:29:34 muse go-librespot[3566]: time="2026-08-24T21:29:34-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:35 muse go-librespot[3566]: time="2026-08-24T21:29:35-04:00" level=debug msg="completed challenge" Aug 24 21:29:35 muse go-librespot[3566]: time="2026-08-24T21:29:35-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:35 muse go-librespot[3566]: time="2026-08-24T21:29:35-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:35 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:35 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:37 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:37 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:38 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:38 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247912. Aug 24 21:29:38 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:38 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:38 muse go-librespot[3588]: Librespot-go daemon starting... Aug 24 21:29:38 muse go-librespot[3588]: time="2026-08-24T21:29:38-04:00" level=info msg="generated new device id: c77a5acad0f668efc5e9ea8520f849526d062c1b" Aug 24 21:29:38 muse go-librespot[3588]: time="2026-08-24T21:29:38-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:38 muse go-librespot[3588]: time="2026-08-24T21:29:38-04:00" level=debug msg="obtained new client token: AAG2VB2pjAnN7FsDtrwQHxOogeMw9ET8UWIPahuIqj9Wr2ls0jZvQm6rr6YTXqFP8sdv0GeQEiiuRYnj0kwsgGhQZH23xzVuBqShq7ZASrwn5DfiuUG7yxihTAZ29OUHPKnrC84Ga9R2bOPDhlyQWRtWEhkqblV0AOvHsTVx/F1rFFzRucWF0lXl1MrPKhJB/vV35Yzmg3gaF6zmsZ6VGtIViwB9snP0aC9vq3PDO8xjH1f/F8iqTOBAjYr9kow=" Aug 24 21:29:38 muse go-librespot[3588]: time="2026-08-24T21:29:38-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 24 21:29:38 muse go-librespot[3588]: time="2026-08-24T21:29:38-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:39 muse go-librespot[3588]: time="2026-08-24T21:29:39-04:00" level=debug msg="completed challenge" Aug 24 21:29:39 muse go-librespot[3588]: time="2026-08-24T21:29:39-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:39 muse go-librespot[3588]: time="2026-08-24T21:29:39-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:39 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:39 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:40 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:40 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:42 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:42 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247913. Aug 24 21:29:42 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:42 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:42 muse go-librespot[3597]: Librespot-go daemon starting... Aug 24 21:29:42 muse go-librespot[3597]: time="2026-08-24T21:29:42-04:00" level=info msg="generated new device id: 2bc615ba80578e73849a1d6a2de6bc7a39d41efb" Aug 24 21:29:42 muse go-librespot[3597]: time="2026-08-24T21:29:42-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:42 muse go-librespot[3597]: time="2026-08-24T21:29:42-04:00" level=debug msg="obtained new client token: AAGXNZujYhZg8zUJZdfU+2KHY5TEL+2fg9xx6tZ3rR9CURmQ7kDBb+jksIhYFBuCHWHAOIGCUGUlH8RHZC6IPQub1nNhKqEjHXBlzSAYsrtSRBjYrYoG+RIWX7y4YK315ajf/nR77LhC4LOZCJnGgfngjM14PmZ2jerwQYsqJVdW5PlDE076an90vaiyqGVknEhlL1hd11KLDG32gGNMlgqK+DxdpP1nljd4xgGTEMjqUdg0IE3uOyPI1URow1A=" Aug 24 21:29:42 muse go-librespot[3597]: time="2026-08-24T21:29:42-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:42 muse go-librespot[3597]: time="2026-08-24T21:29:42-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:43 muse go-librespot[3597]: time="2026-08-24T21:29:43-04:00" level=debug msg="completed challenge" Aug 24 21:29:43 muse go-librespot[3597]: time="2026-08-24T21:29:43-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:43 muse go-librespot[3597]: time="2026-08-24T21:29:43-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:43 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:43 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:43 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:43 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: read ECONNRESET Aug 24 21:29:44 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:44 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:46 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:46 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:46 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:46 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247914. Aug 24 21:29:46 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:46 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:46 muse go-librespot[3619]: Librespot-go daemon starting... Aug 24 21:29:46 muse go-librespot[3619]: time="2026-08-24T21:29:46-04:00" level=info msg="generated new device id: 69fabd3f99035b458f9c4bb3405d25d468cabb22" Aug 24 21:29:46 muse go-librespot[3619]: time="2026-08-24T21:29:46-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:46 muse go-librespot[3619]: time="2026-08-24T21:29:46-04:00" level=debug msg="obtained new client token: AAGKOvB2s0V/xLr6vm5MdzcDeICR1Hc5MYoCLnW/OI6JbQ5m5tR4oAnHyCBPsNNH8cpTkly6oxoruEGq/qQwPkQ6Ig8TiUXI/fPZcZqHteU76o5HXosHauOCk9zi9qQX/gVh4W8L6vGV5SgtZ23vAUY4M5J67fzLZXNdH2v3mlnclKjJfusZVqL7zIPLn6IoFNYBYwptmClKd1PhbjYnPEWNoODrjzGo0BMjt6uk6xkJ3P2GiHfqqyJYYZ3jLL0=" Aug 24 21:29:46 muse go-librespot[3619]: time="2026-08-24T21:29:46-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:46 muse go-librespot[3619]: time="2026-08-24T21:29:46-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:47 muse go-librespot[3619]: time="2026-08-24T21:29:47-04:00" level=debug msg="completed challenge" Aug 24 21:29:47 muse go-librespot[3619]: time="2026-08-24T21:29:47-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:47 muse go-librespot[3619]: time="2026-08-24T21:29:47-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:47 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:47 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:49 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:49 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:50 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:50 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247915. Aug 24 21:29:50 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:50 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:50 muse go-librespot[3627]: Librespot-go daemon starting... Aug 24 21:29:50 muse go-librespot[3627]: time="2026-08-24T21:29:50-04:00" level=info msg="generated new device id: b314bea134228048f5f5fcafceb9c61d030c4943" Aug 24 21:29:50 muse go-librespot[3627]: time="2026-08-24T21:29:50-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:50 muse go-librespot[3627]: time="2026-08-24T21:29:50-04:00" level=debug msg="obtained new client token: AAGbBjHTNp/j5ZdeUrT57jqAa1KGQLzuXznu+54Uupz8f/lWNeeC9kMDVhKYfoZ0dc53hr2PJ8MWIdVk/xQeverqWhMxzHdoiZhxq+9Z+fgpfRsk3IHouImwr9+MN1vEqO0UQcMUyX0q9KXAj4JFNLb9Cr6V5v/lSssnHUUfZzqTpGuTSP1k/okIOZqqkIRR5uJc1/C0mfzZqGrx++Iss4e2B3pFLCZSOibaISFQI/N1UVJ+VVcWJdQzMkmsEoc=" Aug 24 21:29:50 muse go-librespot[3627]: time="2026-08-24T21:29:50-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:50 muse go-librespot[3627]: time="2026-08-24T21:29:50-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:51 muse go-librespot[3627]: time="2026-08-24T21:29:51-04:00" level=debug msg="completed challenge" Aug 24 21:29:51 muse go-librespot[3627]: time="2026-08-24T21:29:51-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:51 muse go-librespot[3627]: time="2026-08-24T21:29:51-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:51 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:51 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:52 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:52 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:54 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:54 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247916. Aug 24 21:29:54 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:54 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:54 muse go-librespot[3635]: Librespot-go daemon starting... Aug 24 21:29:54 muse go-librespot[3635]: time="2026-08-24T21:29:54-04:00" level=info msg="generated new device id: 93f3df1209e1f87de5b10c5777aa0b9934de4266" Aug 24 21:29:54 muse go-librespot[3635]: time="2026-08-24T21:29:54-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:54 muse go-librespot[3635]: time="2026-08-24T21:29:54-04:00" level=debug msg="obtained new client token: AAErNgCAI8BaQ+UX3VCTrGVKd3moULyV9rs3imgBb9xRN3EsBmML1k2PGLwFI+2xFsTgYQtzwH9cvwBH8Ufik4qlR7iH/rLMbvwVz8178pjn65Bjn1wEbuOfPmj1S0OIBq0IY9whLQxpJhTxDj3DQftRzmnwf6zfxJq4pgT5hA79S4lmoPDKMPQ2MMEs/jC0StYNgKsEQi1LLFtAb6BZb3e4/hWlmdljLdA8IYmfqFSofyFFokXnWLPm11ZJ3sE=" Aug 24 21:29:54 muse go-librespot[3635]: time="2026-08-24T21:29:54-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:54 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:54 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:54 muse volumio[30448]: info: Listing playlists Aug 24 21:29:54 muse volumio[30448]: info: Listing playlists Aug 24 21:29:54 muse go-librespot[3635]: time="2026-08-24T21:29:54-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:55 muse go-librespot[3635]: time="2026-08-24T21:29:55-04:00" level=debug msg="completed challenge" Aug 24 21:29:55 muse go-librespot[3635]: time="2026-08-24T21:29:55-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:55 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:55 muse go-librespot[3635]: time="2026-08-24T21:29:55-04:00" level=debug msg="new websocket client" Aug 24 21:29:55 muse volumio[30448]: info: Connection to go-librespot Websocket established Aug 24 21:29:55 muse go-librespot[3635]: time="2026-08-24T21:29:55-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:55 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:55 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:29:55 muse volumio[30448]: info: Connection to go-librespot Websocket closed Aug 24 21:29:58 muse volumio[30448]: info: Getting Spotify volume Aug 24 21:29:58 muse volumio[30448]: (node:30448) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:58 muse volumio[30448]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Aug 24 21:29:58 muse volumio[30448]: (node:30448) 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: 45320) Aug 24 21:29:58 muse volumio[30448]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 24 21:29:58 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:29:58 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:29:58 muse volumio[30448]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 24 21:29:58 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:29:58 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:29:58 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:29:58 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247917. Aug 24 21:29:58 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:29:58 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:29:58 muse go-librespot[3657]: Librespot-go daemon starting... Aug 24 21:29:58 muse go-librespot[3657]: time="2026-08-24T21:29:58-04:00" level=info msg="generated new device id: 81d9b8de475a685d0f0b8df74fda4e0b8650e2bc" Aug 24 21:29:58 muse go-librespot[3657]: time="2026-08-24T21:29:58-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:58 muse go-librespot[3657]: time="2026-08-24T21:29:58-04:00" level=debug msg="obtained new client token: AAHneXygWwOG2gFrPdktsoKGDLkFc06MsFXcNyCyUolxqppFLKr7Wdq2erFGl5AHFm1KA8V+/Cq0IH3DfqlarEQHl8DWIsFYvbtAtkPHAi9rr9RFfy8l+/8aVjAEj/elsochh/6t1DsSjpEQzjgOkm+O5cwjVwxnKL1sH9w86bqXByVr010koi55NOQiaKH7VvT/JPdI5q6g5fxKQ3i+kQLUP5KInDpEQQvC99DfE+XR6MzekBmrpTmBl4xkn/g=" Aug 24 21:29:58 muse go-librespot[3657]: time="2026-08-24T21:29:58-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:29:58 muse go-librespot[3657]: time="2026-08-24T21:29:58-04:00" level=debug msg="completed keyexchange" Aug 24 21:29:59 muse go-librespot[3657]: time="2026-08-24T21:29:59-04:00" level=debug msg="completed challenge" Aug 24 21:29:59 muse go-librespot[3657]: time="2026-08-24T21:29:59-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:29:59 muse go-librespot[3657]: time="2026-08-24T21:29:59-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:29:59 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:29:59 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:30:01 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:01 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:02 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:30:02 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247918. Aug 24 21:30:02 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:30:02 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:30:02 muse go-librespot[3666]: Librespot-go daemon starting... Aug 24 21:30:02 muse go-librespot[3666]: time="2026-08-24T21:30:02-04:00" level=info msg="generated new device id: 8c95a75dd003bb4a7a116b52a3411157927a110f" Aug 24 21:30:02 muse go-librespot[3666]: time="2026-08-24T21:30:02-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:02 muse go-librespot[3666]: time="2026-08-24T21:30:02-04:00" level=debug msg="obtained new client token: AAHBIrW3opUmOBTemGomEoU6Z0MkQNADvnLZtxEx4E+6TUJf7YrZlLXj0Rb6/GWJVl94pi2e2xBxS3qOiM4J2aAHr4M8+q3LAM/5M2Fczs7+0+5Fbv6+k/RCGAJEmQSGl1nP2xEwxlWnRYk+XtazgCKt1WqPDAJuWow/DujED2vpgQTedo/rrjD0//otQoEMWF7CyJdSRdk8oPrbra//nMlehKOT4cKnAf4UWgNSk3wUVlF1vdXwGJH93PakRog=" Aug 24 21:30:02 muse go-librespot[3666]: time="2026-08-24T21:30:02-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:30:02 muse go-librespot[3666]: time="2026-08-24T21:30:02-04:00" level=debug msg="completed keyexchange" Aug 24 21:30:03 muse go-librespot[3666]: time="2026-08-24T21:30:03-04:00" level=debug msg="completed challenge" Aug 24 21:30:03 muse go-librespot[3666]: time="2026-08-24T21:30:03-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:03 muse go-librespot[3666]: time="2026-08-24T21:30:03-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:30:03 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:30:03 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:30:04 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:04 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:04 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:30:04 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:30:06 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:30:06 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247919. Aug 24 21:30:06 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:30:06 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:30:06 muse go-librespot[3688]: Librespot-go daemon starting... Aug 24 21:30:06 muse go-librespot[3688]: time="2026-08-24T21:30:06-04:00" level=info msg="generated new device id: a55545e483e25d0b473a0f1bb58f5007ec901afa" Aug 24 21:30:06 muse go-librespot[3688]: time="2026-08-24T21:30:06-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:06 muse go-librespot[3688]: time="2026-08-24T21:30:06-04:00" level=debug msg="obtained new client token: AAFwm3okQvskquf9mAhn72CC+sprDFS+xu767c9zXXDWfLHdQcEG/GberD/1E9WKnS5S2+1GdglfrU6VeyRFtf9VNsCpmLW+NXoa+3uGL7Nvrz3/kBlN8sjiWhIOvwib0ekxs1bu50tuZWyhNLlyrJ03hvlPTf+9V4cuxH7CWjMcJbPmzmmlvq6HwvhHYNEqRY6mDLdlCODmXsiPm6KX2l7VLB1n8KjoE2O9z8TbQlCecbz3zenU3Gf/+nvfULY=" Aug 24 21:30:06 muse go-librespot[3688]: time="2026-08-24T21:30:06-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:30:06 muse go-librespot[3688]: time="2026-08-24T21:30:06-04:00" level=debug msg="completed keyexchange" Aug 24 21:30:07 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:07 muse go-librespot[3688]: time="2026-08-24T21:30:07-04:00" level=debug msg="new websocket client" Aug 24 21:30:07 muse volumio[30448]: info: Connection to go-librespot Websocket established Aug 24 21:30:07 muse go-librespot[3688]: time="2026-08-24T21:30:07-04:00" level=debug msg="completed challenge" Aug 24 21:30:07 muse go-librespot[3688]: time="2026-08-24T21:30:07-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:07 muse go-librespot[3688]: time="2026-08-24T21:30:07-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:30:07 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:30:07 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:30:07 muse volumio[30448]: info: Connection to go-librespot Websocket closed Aug 24 21:30:10 muse volumio[30448]: info: Getting Spotify volume Aug 24 21:30:10 muse volumio[30448]: (node:30448) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:10 muse volumio[30448]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Aug 24 21:30:10 muse volumio[30448]: (node:30448) 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: 45321) Aug 24 21:30:10 muse volumio[30448]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 24 21:30:10 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:30:10 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:30:10 muse volumio[30448]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 24 21:30:10 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:10 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:10 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:30:10 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247920. Aug 24 21:30:10 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:30:10 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:30:10 muse go-librespot[3737]: Librespot-go daemon starting... Aug 24 21:30:10 muse go-librespot[3737]: time="2026-08-24T21:30:10-04:00" level=info msg="generated new device id: 2341d4c725205165bd8e0856a5e849e6bf9649ba" Aug 24 21:30:10 muse go-librespot[3737]: time="2026-08-24T21:30:10-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:10 muse go-librespot[3737]: time="2026-08-24T21:30:10-04:00" level=debug msg="obtained new client token: AAETlzBnJv8wN7T5lwYnQFKI1HhXh6qhjvDuL80ImKTJeS5aGwY4mqwNgNbCDxki2IPy/hlFy/L5mmOxYOOtP5/hT+MVKjElBNTKjtf16V8AzYR1wvePZk5c10kTBtTmZuYBW7qqo29cKxT0SDcnJIBgUzm8wR8nahDJBmii1bHqe9+Uw7U4MqL5vuYsZ3bl7OTehMUHDpLUDhmNFE9rKfyoJoqFjLUGif1FlKMtO4PBoufxjfvlEcahry4eqBs=" Aug 24 21:30:10 muse go-librespot[3737]: time="2026-08-24T21:30:10-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:30:10 muse go-librespot[3737]: time="2026-08-24T21:30:10-04:00" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.255.62:4070: connect: connection refused" Aug 24 21:30:10 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:30:10 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:30:13 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:13 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:13 muse systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 24 21:30:13 muse systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 247921. Aug 24 21:30:13 muse systemd[1]: Stopped go-librespot Daemon. Aug 24 21:30:13 muse systemd[1]: Started go-librespot Daemon. Aug 24 21:30:13 muse go-librespot[3746]: Librespot-go daemon starting... Aug 24 21:30:13 muse go-librespot[3746]: time="2026-08-24T21:30:13-04:00" level=info msg="generated new device id: 8a08f48c620768f7052afa568f1e3ce35eba2e7c" Aug 24 21:30:13 muse go-librespot[3746]: time="2026-08-24T21:30:13-04:00" level=debug msg="stored credentials found for 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:13 muse go-librespot[3746]: time="2026-08-24T21:30:13-04:00" level=debug msg="obtained new client token: AAGYMiCKr+G+TCFLpUhe7pfxfnFIgwsVZQatbq8IU725nSMAm1Qe37hKXyO+Vazznowl9toffxpzWtk+d2KGFJqpOkSqbjUR6A+dRPeQHvOqJOgqBkGafwzE551nSklcHtg3tPqzuLJ/D9qV+40ToxN+zzmUwC5k24ibUZ/9lHVidqRxSf0CSqRmnCQVgxSxRketucjYRGmkes7MvVgas/TKHJRGunYdVR9tNO/xOROWo91PrZfNyzqIB1juJ94=" Aug 24 21:30:13 muse go-librespot[3746]: time="2026-08-24T21:30:13-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 24 21:30:14 muse go-librespot[3746]: time="2026-08-24T21:30:14-04:00" level=debug msg="completed keyexchange" Aug 24 21:30:14 muse volumio[30448]: info: CoreCommandRouter::volumioGetState Aug 24 21:30:14 muse volumio[30448]: info: CorePlayQueue::getTrack 11 Aug 24 21:30:14 muse go-librespot[3746]: time="2026-08-24T21:30:14-04:00" level=debug msg="completed challenge" Aug 24 21:30:14 muse volumio[30448]: info: Listing playlists Aug 24 21:30:14 muse volumio[30448]: info: Listing playlists Aug 24 21:30:14 muse go-librespot[3746]: time="2026-08-24T21:30:14-04:00" level=debug msg="authenticated as 3punduu3o3ozz0bcox79m88zs" Aug 24 21:30:14 muse go-librespot[3746]: time="2026-08-24T21:30:14-04:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 24 21:30:14 muse systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 24 21:30:14 muse systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 24 21:30:16 muse volumio[30448]: info: Initializing connection to go-librespot Websocket Aug 24 21:30:16 muse volumio[30448]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 24 21:30:17 muse volumio[30448]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 21:30:17 muse volumio[30448]: Error: read ETIMEDOUT Aug 24 21:30:17 muse volumio[30448]: at TCP.onStreamRead (internal/stream_base_commons.js:209:20) { Aug 24 21:30:17 muse volumio[30448]: errno: -110, Aug 24 21:30:17 muse volumio[30448]: code: 'ETIMEDOUT', Aug 24 21:30:17 muse volumio[30448]: syscall: 'read' Aug 24 21:30:17 muse volumio[30448]: } Aug 24 21:30:17 muse volumio[30448]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 21:30:17 muse sudo[3777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-24 21:29 Aug 24 21:30:17 muse sudo[3777]: 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="5c0e72e4b5817fe66c91c9d15d75ff13b8e3f4ba" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 30 Mar 2026 02:51:29 PM CEST" VOLUMIO_VERSION="3.914" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="98fe12c88d8ff391f569279e2f874892"