-- Logs begin at Sat 2025-05-10 16:55:58 +07, end at Sat 2025-05-10 19:32:41 +07. -- May 10 19:31:01 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:31:01 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:01 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:31:01 volumio2 volumio[1015]: (node:1015) 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: 78901) May 10 19:31:01 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:31:01 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:01 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:31:02 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:02 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:02 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:02 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351337. May 10 19:31:02 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:02 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:02 volumio2 go-librespot[11673]: Librespot-go daemon starting... May 10 19:31:02 volumio2 go-librespot[11673]: time="2025-05-10T19:31:02+07:00" level=info msg="generated new device id: a7acd559eeb3c53cd308feabbd2e4ad2bf20d130" May 10 19:31:02 volumio2 go-librespot[11673]: time="2025-05-10T19:31:02+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:02 volumio2 go-librespot[11673]: time="2025-05-10T19:31:02+07:00" level=debug msg="obtained new client token: AABGHEQIZuOe85jiiv6jrE7M42l+BtqT4tW9dGitVcxiQwZMJ8Oe1oHirG+ga+fbhNrz2LNCxcMx2g5ywiF2j4SM6kT01jSOLapfkadv6hxHEWeL2RWEBe24tlO6IIZCzIcKW5+zXsKTQKOVodDO14ohw9YB5JJHSPa1dMZCX7DQ42m+15ezX7fTY3RYYQll09hyQ/CqDa8ILT7P5lk6yH0N4GQ2uBDJ2KqZ/Vx4LXRj7hdAYLRHJ6IQWEsEitg=" May 10 19:31:02 volumio2 go-librespot[11673]: time="2025-05-10T19:31:02+07:00" 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]" May 10 19:31:02 volumio2 go-librespot[11673]: time="2025-05-10T19:31:02+07:00" level=debug msg="completed keyexchange" May 10 19:31:03 volumio2 go-librespot[11673]: time="2025-05-10T19:31:03+07:00" level=debug msg="completed challenge" May 10 19:31:03 volumio2 go-librespot[11673]: time="2025-05-10T19:31:03+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:03 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:03 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:05 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:05 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:06 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:06 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351338. May 10 19:31:06 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:06 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:06 volumio2 go-librespot[11688]: Librespot-go daemon starting... May 10 19:31:06 volumio2 go-librespot[11688]: time="2025-05-10T19:31:06+07:00" level=info msg="generated new device id: cfd2ee4ac09d38e345f465a0b66535aa09864469" May 10 19:31:06 volumio2 go-librespot[11688]: time="2025-05-10T19:31:06+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:06 volumio2 go-librespot[11688]: time="2025-05-10T19:31:06+07:00" level=debug msg="obtained new client token: AACfKzMLLTokWKHyvDzFD0JwVq7mZ3ywm3YZ6ROGFsUlX7ilRvFwmkG1M1/XD4suNihdAQkGlNHeaN9pN48iEJN/Q3/UKhxFU/UWiRouh8X5fCTk2VZW1e86l20wd++NAbz7Z3hAfVwzRNSho+1yIcnjpzAQ7qVe7PTGJ9vt+Mo/cPdpbtliEmZfuGCnVMiP+9qheL3ZpUFxmQeMAhTxHRpM38WmuTU4NX1HQHQS/RZSpKTpEMlIvOuE1kQuNMA=" May 10 19:31:06 volumio2 go-librespot[11688]: time="2025-05-10T19:31:06+07:00" 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]" May 10 19:31:06 volumio2 go-librespot[11688]: time="2025-05-10T19:31:06+07:00" level=debug msg="completed keyexchange" May 10 19:31:07 volumio2 go-librespot[11688]: time="2025-05-10T19:31:07+07:00" level=debug msg="completed challenge" May 10 19:31:07 volumio2 go-librespot[11688]: time="2025-05-10T19:31:07+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:07 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:07 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:08 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:08 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:10 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:10 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351339. May 10 19:31:10 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:10 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:10 volumio2 go-librespot[11722]: Librespot-go daemon starting... May 10 19:31:10 volumio2 go-librespot[11722]: time="2025-05-10T19:31:10+07:00" level=info msg="generated new device id: 1cdf3058247b30596b18421fd8874bd19e51a0a0" May 10 19:31:10 volumio2 go-librespot[11722]: time="2025-05-10T19:31:10+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:10 volumio2 go-librespot[11722]: time="2025-05-10T19:31:10+07:00" level=debug msg="obtained new client token: AADBepr6/DWYM/p3bv2tnUZUANc5/pYKOw/Kvvrfv9kYlW0eazH8K0Ne6qFoayC+XiNVvdAeayUVZptvfzuE7qoY8EZqDtr9wzi1N0IOIU3/hwTmKEpHGJDPdqnuPWLffwSg3PSBonc+5PMmKjOCtyWEV0O8xZZzy70N/FkZAuGT4cRwwKygh+Cwga1GGgWVaMeDVtLdjwskA+rhVdEN/gGYZckcJiGJFpm57Z6bVIJVre26yJz+D+zcce+0K2I=" May 10 19:31:11 volumio2 go-librespot[11722]: time="2025-05-10T19:31:11+07:00" 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]" May 10 19:31:11 volumio2 go-librespot[11722]: time="2025-05-10T19:31:11+07:00" level=debug msg="completed keyexchange" May 10 19:31:11 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:11 volumio2 go-librespot[11722]: time="2025-05-10T19:31:11+07:00" level=debug msg="new websocket client" May 10 19:31:11 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:31:11 volumio2 go-librespot[11722]: time="2025-05-10T19:31:11+07:00" level=debug msg="completed challenge" May 10 19:31:11 volumio2 go-librespot[11722]: time="2025-05-10T19:31:11+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:11 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:31:11 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:11 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:14 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:31:14 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:14 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:31:14 volumio2 volumio[1015]: (node:1015) 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: 78902) May 10 19:31:14 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:31:14 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:14 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:31:14 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:14 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:14 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:14 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351340. May 10 19:31:14 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:14 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:14 volumio2 go-librespot[11738]: Librespot-go daemon starting... May 10 19:31:14 volumio2 go-librespot[11738]: time="2025-05-10T19:31:14+07:00" level=info msg="generated new device id: b9df0ba78203d5bf2df0607304923861fa117ff2" May 10 19:31:14 volumio2 go-librespot[11738]: time="2025-05-10T19:31:14+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:15 volumio2 go-librespot[11738]: time="2025-05-10T19:31:15+07:00" level=debug msg="obtained new client token: AAACKWeYfDM34kAM6VXCa06zjSW+quUdhmZFhurMJVdcyz/XkSu81AGKC5dUezUT9ypYUuZpgIql1z2j0p/SWwo6XkoaprOMRvDrb9aM30Cxy+64ZT/i+wWjtf4YFstfmCt6BzQivggBV19i6qTGm42VM1YJjkmdl/guFQlw1SWeO8F6VO+mWxeYo9aZF0q1F3qKGREt/RYhaLHy/+sG8uAX1LOuhbYqan8mO2UagQiqFZnipPpGyy19dIDB" May 10 19:31:15 volumio2 go-librespot[11738]: time="2025-05-10T19:31:15+07:00" 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]" May 10 19:31:15 volumio2 go-librespot[11738]: time="2025-05-10T19:31:15+07:00" level=debug msg="completed keyexchange" May 10 19:31:15 volumio2 go-librespot[11738]: time="2025-05-10T19:31:15+07:00" level=debug msg="completed challenge" May 10 19:31:15 volumio2 go-librespot[11738]: time="2025-05-10T19:31:15+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:15 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:15 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:17 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:17 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:18 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:18 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351341. May 10 19:31:18 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:18 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:18 volumio2 go-librespot[11769]: Librespot-go daemon starting... May 10 19:31:18 volumio2 go-librespot[11769]: time="2025-05-10T19:31:18+07:00" level=info msg="generated new device id: 94dfbca35401943de206d2b5538a43e4ef65a71e" May 10 19:31:18 volumio2 go-librespot[11769]: time="2025-05-10T19:31:18+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:19 volumio2 go-librespot[11769]: time="2025-05-10T19:31:19+07:00" level=debug msg="obtained new client token: AADL8yio0p4EPdjOFCM8Y+BkzS9ku6zpE600kxNiYngZCqU+E22QZWl1wVFi7WUY5b25Z8PRSjED3YRf9FGv8UdoU4EKnbYR1FXdUTkENwV54SJlVPTOva+eD3wfEg/galL2DoSvzaslU3wm8Iwz6M5jzRVu045CV8N0FQy9eYBcgPgowq4vuMLyCe0QybuygXVKIxIXz0eiENxSOWTTpxkpZ4AEOBDiMYy3o4XssbnCmYXHtOqQ4W9+f+Nd" May 10 19:31:19 volumio2 go-librespot[11769]: time="2025-05-10T19:31:19+07:00" 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]" May 10 19:31:19 volumio2 go-librespot[11769]: time="2025-05-10T19:31:19+07:00" level=debug msg="completed keyexchange" May 10 19:31:19 volumio2 go-librespot[11769]: time="2025-05-10T19:31:19+07:00" level=debug msg="completed challenge" May 10 19:31:19 volumio2 go-librespot[11769]: time="2025-05-10T19:31:19+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:19 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:19 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:20 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:20 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:22 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:22 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351342. May 10 19:31:22 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:22 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:22 volumio2 go-librespot[11784]: Librespot-go daemon starting... May 10 19:31:22 volumio2 go-librespot[11784]: time="2025-05-10T19:31:22+07:00" level=info msg="generated new device id: 0a8d81e5f0a4997cccc59c1118e167e6db9a98e8" May 10 19:31:22 volumio2 go-librespot[11784]: time="2025-05-10T19:31:22+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" level=debug msg="obtained new client token: AABPswOwBJrng//79NDZ5FgM3v5q9niVyEaJ8yYfTMYG//p3HDcfWEAxtT+JBKLgFmEf4OIiWREkKoxzpnrqm0deNw2AzX+Ft1Jbm61lCAlAsvFwqsIXbaXDXn1ppHs3G/M0jp61EUDd3x9VsaKrbylBckgVX0bnG0uCeZyfXCIDugwz5P/pZiuJUO0WF8ohY7t17PXf1uNhVdBbef34t+0flbMkfe++Zztd4U0zWlay1PrDhDGQ17minfAP" May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" 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]" May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" level=debug msg="completed keyexchange" May 10 19:31:23 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" level=debug msg="new websocket client" May 10 19:31:23 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" level=debug msg="completed challenge" May 10 19:31:23 volumio2 go-librespot[11784]: time="2025-05-10T19:31:23+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:23 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:31:23 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:23 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:26 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:31:26 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:26 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:31:26 volumio2 volumio[1015]: (node:1015) 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: 78903) May 10 19:31:26 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:31:26 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:26 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:31:26 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:26 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:26 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:26 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351343. May 10 19:31:26 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:26 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:26 volumio2 go-librespot[11799]: Librespot-go daemon starting... May 10 19:31:26 volumio2 go-librespot[11799]: time="2025-05-10T19:31:26+07:00" level=info msg="generated new device id: c33f44cf48762f9dd455c37d3daf238f04b0587f" May 10 19:31:26 volumio2 go-librespot[11799]: time="2025-05-10T19:31:26+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:27 volumio2 go-librespot[11799]: time="2025-05-10T19:31:27+07:00" level=debug msg="obtained new client token: AAA0XbF3qQyeEYkfz6s8AtV1yHLg0Uts4schaAHneJlSZadlV+4D1AQc2ujYw7wbBxmkfYVAlWTThg6epyCGiDF0LWSfTVuV2wv5NmHHSO12kRYGgqNbg8rFc9z4a3M0QGJxaMdBTmhoF10ZnihYlHyzfOUagGCMchTc0x4hnwxu6nRYJMmaXKn9Q8xyL3vUDJ1w0rPIR5pvhGmaPdCHrt8dQXKu04UbKUT4MpCAgInM9jVKGTlQHjhIyl/z" May 10 19:31:27 volumio2 go-librespot[11799]: time="2025-05-10T19:31:27+07:00" 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]" May 10 19:31:27 volumio2 go-librespot[11799]: time="2025-05-10T19:31:27+07:00" level=debug msg="completed keyexchange" May 10 19:31:27 volumio2 go-librespot[11799]: time="2025-05-10T19:31:27+07:00" level=debug msg="completed challenge" May 10 19:31:27 volumio2 go-librespot[11799]: time="2025-05-10T19:31:27+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:27 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:27 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:29 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:29 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:31 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:31 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351344. May 10 19:31:31 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:31 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:31 volumio2 go-librespot[11876]: Librespot-go daemon starting... May 10 19:31:31 volumio2 go-librespot[11876]: time="2025-05-10T19:31:31+07:00" level=info msg="generated new device id: a070ab514ac33edb17c0f34a78de56c0176c7c1f" May 10 19:31:31 volumio2 go-librespot[11876]: time="2025-05-10T19:31:31+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:31 volumio2 go-librespot[11876]: time="2025-05-10T19:31:31+07:00" level=debug msg="obtained new client token: AABZUdGlfTHaUZh4pMP+7c9o2MT2FTDP4VlB3geme+kS9ZGqO2aQjIpR2vPUPB4Sc7I139REVS5DXN23uXubf31r/gZivk1NYdd+PPqaUO3Oud9soCFC4SkccDQ6Xdk1y1bshYAw5qLlLWa1DM5bdfdCDqsklxNQGgQGr3F0kPW3JLnPGYZk31bhd3xgYkcY/9divE0WHkvBMiIdAZr5lJ9b6FUfMqVZKApD1NWNorlb8364zdi3JOxQMnTBF2g=" May 10 19:31:31 volumio2 go-librespot[11876]: time="2025-05-10T19:31:31+07:00" 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]" May 10 19:31:31 volumio2 go-librespot[11876]: time="2025-05-10T19:31:31+07:00" level=debug msg="completed keyexchange" May 10 19:31:32 volumio2 go-librespot[11876]: time="2025-05-10T19:31:32+07:00" level=debug msg="completed challenge" May 10 19:31:32 volumio2 go-librespot[11876]: time="2025-05-10T19:31:32+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:32 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:32 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:32 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:32 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:35 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:35 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351345. May 10 19:31:35 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:35 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:35 volumio2 go-librespot[11899]: Librespot-go daemon starting... May 10 19:31:35 volumio2 go-librespot[11899]: time="2025-05-10T19:31:35+07:00" level=info msg="generated new device id: ee397a77459b21a8c51c3aead88a4d331f5c0252" May 10 19:31:35 volumio2 go-librespot[11899]: time="2025-05-10T19:31:35+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:35 volumio2 go-librespot[11899]: time="2025-05-10T19:31:35+07:00" level=debug msg="obtained new client token: AAArIQmiNkh4d4uzKH7wHLROoEnJSIEoaLUJdjsP6EtZiLj56BGtv9yzBPPp0EhNUTM1TJXK7oX3n2REMR9U+IVW3TNlouMVdz3khU1obNO9t8z8D5CS7Q6SsLcEyrc3NBkUCp/a4PXvTyYTrazaGbYb7a7dbUFlDcelleBrNPzBsNHStjU8hmdEKCFg7fiGrprrcrb8O6f4bDC/MSSWBvDExOYcFfoV8KBukP9ZAJawJ9OztTsxGmwgCuePAiE=" May 10 19:31:35 volumio2 go-librespot[11899]: time="2025-05-10T19:31:35+07:00" 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]" May 10 19:31:35 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:35 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:31:35 volumio2 go-librespot[11899]: time="2025-05-10T19:31:35+07:00" level=debug msg="new websocket client" May 10 19:31:38 volumio2 volumio[1015]: error: Upnp client error: Error: This socket has been ended by the other party May 10 19:31:38 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:31:38 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:31:38 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:38 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:31:39 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 10 19:31:39 volumio2 volumio[1015]: info: Received Get System Info May 10 19:31:39 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:31:39 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:31:39 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:31:39 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:39 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:31:40 volumio2 go-librespot[11899]: time="2025-05-10T19:31:40+07:00" level=debug msg="completed keyexchange" May 10 19:31:41 volumio2 go-librespot[11899]: time="2025-05-10T19:31:41+07:00" level=debug msg="completed challenge" May 10 19:31:41 volumio2 go-librespot[11899]: time="2025-05-10T19:31:41+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:41 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: socket hang up May 10 19:31:41 volumio2 volumio[1015]: at connResetException (internal/errors.js:639:14) May 10 19:31:41 volumio2 volumio[1015]: at Socket.socketOnEnd (_http_client.js:499:23) May 10 19:31:41 volumio2 volumio[1015]: at Socket.emit (events.js:412:35) May 10 19:31:41 volumio2 volumio[1015]: at endReadableNT (internal/streams/readable.js:1333:12) May 10 19:31:41 volumio2 volumio[1015]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 10 19:31:41 volumio2 volumio[1015]: (node:1015) 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: 78904) May 10 19:31:41 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:31:41 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:41 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:44 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:44 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:44 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:44 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351346. May 10 19:31:44 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:44 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:44 volumio2 go-librespot[11932]: Librespot-go daemon starting... May 10 19:31:44 volumio2 go-librespot[11932]: time="2025-05-10T19:31:44+07:00" level=info msg="generated new device id: 593cb244d47f6ceb939a8d3a9e6f2f3727ce8379" May 10 19:31:44 volumio2 go-librespot[11932]: time="2025-05-10T19:31:44+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:44 volumio2 go-librespot[11932]: time="2025-05-10T19:31:44+07:00" level=debug msg="obtained new client token: AAANPfAsWOKjTakPKXBnYVNHeoI32U0QhHjsfqgu32m3YlpILgwkhsuRkL7b2u/5DtK1qWaTgbVq4FwR/LC8fQ0YUGqsFy+j0Fr133ITsk4rO2wqjDQovekhYPENtL5y6fy8eo1i62yuVeVik+cMEHT+bK9Fgv4eFxgJPAw7Ig6Maztcx4yr0+TX2jm49Hh5Z8X2WDCEwlJUGBcZtM4CBi7nS2TXpMF7IjFpSlbnDqZjUeDFBl/Nvr7lx9DkBFM=" May 10 19:31:44 volumio2 go-librespot[11932]: time="2025-05-10T19:31:44+07:00" 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]" May 10 19:31:44 volumio2 go-librespot[11932]: time="2025-05-10T19:31:44+07:00" level=debug msg="completed keyexchange" May 10 19:31:45 volumio2 go-librespot[11932]: time="2025-05-10T19:31:45+07:00" level=debug msg="completed challenge" May 10 19:31:45 volumio2 go-librespot[11932]: time="2025-05-10T19:31:45+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:45 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:45 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:47 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:47 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:48 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:48 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351347. May 10 19:31:48 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:48 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:48 volumio2 go-librespot[11943]: Librespot-go daemon starting... May 10 19:31:48 volumio2 go-librespot[11943]: time="2025-05-10T19:31:48+07:00" level=info msg="generated new device id: 58fc64f9914be6654d0569de9709ce4276c9f0f9" May 10 19:31:48 volumio2 go-librespot[11943]: time="2025-05-10T19:31:48+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:48 volumio2 go-librespot[11943]: time="2025-05-10T19:31:48+07:00" level=debug msg="obtained new client token: AADevFQphbLMu9Ha+8wx/Uu6HOGCsfneTYf7JwkWXObfJ0qyUfGje2Wjnt5Hwmk7S9yflliTHKjYtxgrNPCMw9vHITrvBB0Q9DRoFJNUn8qGeyy0LvTAf4JAwbWpC9wG4HFloxX945XnvxH2UF/BmLlzNZQPF6XlX5kMBTwdMTgG7AcKcexXPNf1auiPb4412q2J8fvTYpwDWlx+t2w++Ek9fS7LXzdKEUqHE6MmFNDXHBNvkWxUCocCa4j5R8Y=" May 10 19:31:48 volumio2 go-librespot[11943]: time="2025-05-10T19:31:48+07:00" 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]" May 10 19:31:48 volumio2 go-librespot[11943]: time="2025-05-10T19:31:48+07:00" level=debug msg="completed keyexchange" May 10 19:31:49 volumio2 go-librespot[11943]: time="2025-05-10T19:31:49+07:00" level=debug msg="completed challenge" May 10 19:31:49 volumio2 go-librespot[11943]: time="2025-05-10T19:31:49+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:49 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:49 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:50 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:50 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:52 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:52 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351348. May 10 19:31:52 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:52 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:52 volumio2 go-librespot[11969]: Librespot-go daemon starting... May 10 19:31:52 volumio2 go-librespot[11969]: time="2025-05-10T19:31:52+07:00" level=info msg="generated new device id: 1569fdded6c75e77c4431b878e941faf75264e02" May 10 19:31:52 volumio2 go-librespot[11969]: time="2025-05-10T19:31:52+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:52 volumio2 go-librespot[11969]: time="2025-05-10T19:31:52+07:00" level=debug msg="obtained new client token: AADxcoA1x8JI8E7jQc9soL8wbucNz9oJOGarq/0kYEhsXy7vMkGOlbH5igUClDpQAQEr8E1kngLQ89RJn6N4LVkutlgiuwayan6fG6UU4Tb36f+EWJsw2JuxyVbpLrTkbAHIAy2lGHtWzTQAouO2MLCqvNiblulR1Jr+rw7joyJlzElHAbQzAfAOpK7xO04P+Rk1ZgOoKrjPBOhMHsT1vVxUorl0i2bb9GvSMkFBBtm9oCcdbhhBfNPz3hK1SYE=" May 10 19:31:52 volumio2 go-librespot[11969]: time="2025-05-10T19:31:52+07:00" 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]" May 10 19:31:52 volumio2 go-librespot[11969]: time="2025-05-10T19:31:52+07:00" level=debug msg="completed keyexchange" May 10 19:31:53 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:53 volumio2 go-librespot[11969]: time="2025-05-10T19:31:53+07:00" level=debug msg="new websocket client" May 10 19:31:53 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:31:53 volumio2 go-librespot[11969]: time="2025-05-10T19:31:53+07:00" level=debug msg="completed challenge" May 10 19:31:53 volumio2 go-librespot[11969]: time="2025-05-10T19:31:53+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:53 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:31:53 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:53 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:56 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:31:56 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:56 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:31:56 volumio2 volumio[1015]: (node:1015) 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: 78905) May 10 19:31:56 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:31:56 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:31:56 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:31:56 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:56 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:31:56 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:31:56 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351349. May 10 19:31:56 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:31:56 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:31:56 volumio2 go-librespot[11976]: Librespot-go daemon starting... May 10 19:31:56 volumio2 go-librespot[11976]: time="2025-05-10T19:31:56+07:00" level=info msg="generated new device id: ff0048f70e1a39b17ee661285461a0dae5f16daf" May 10 19:31:56 volumio2 go-librespot[11976]: time="2025-05-10T19:31:56+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:31:56 volumio2 go-librespot[11976]: time="2025-05-10T19:31:56+07:00" level=debug msg="obtained new client token: AADyzkt6OSVFW9RO9gAxYnjJbQLbZuXvWLzj433+4SP77iF725xs4z8rJHQF7FM7LmiVgizvioutgP8A6GNOR+Z4RcP7/BrpndGoCPVE3Wd6B0k1BzESVOyqnBZGv1hae/BNC3sAqwb2Q2Ld4BOFEklQ0EnaU+1OXw/4uNUZ2NDNTp9fbfl7W/57+sWTm62rBXMiWdLaZCSMfJk8Mtv/ZLUMUs8gLGf/zzpFgx4b5Kl1E+oRw3B8sYV5+Dk+ujE=" May 10 19:31:57 volumio2 go-librespot[11976]: time="2025-05-10T19:31:57+07:00" 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]" May 10 19:31:57 volumio2 go-librespot[11976]: time="2025-05-10T19:31:57+07:00" level=debug msg="completed keyexchange" May 10 19:31:57 volumio2 go-librespot[11976]: time="2025-05-10T19:31:57+07:00" level=debug msg="completed challenge" May 10 19:31:57 volumio2 go-librespot[11976]: time="2025-05-10T19:31:57+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:31:57 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:31:57 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:31:59 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:31:59 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:00 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:00 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351350. May 10 19:32:00 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:00 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:00 volumio2 go-librespot[11997]: Librespot-go daemon starting... May 10 19:32:00 volumio2 go-librespot[11997]: time="2025-05-10T19:32:00+07:00" level=info msg="generated new device id: 2864bffbbf6184361c4df6018426fb97509a190b" May 10 19:32:00 volumio2 go-librespot[11997]: time="2025-05-10T19:32:00+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:00 volumio2 go-librespot[11997]: time="2025-05-10T19:32:00+07:00" level=debug msg="obtained new client token: AABfwgZHb55Q0/fWAQ4jpuf40NhMRiAQiAAwt+GX06ps4RQ2JrS2/teV/ssEtm6wn92KgtsVp8avu+Y8OtJL4c6OW7v30Xb9lLmRCFqgn1wtED+HwBCsW3llBORMvbdaoLUKlXtexHw7BnNBlZlAv43WhtqF/96ATtRl3+DCgk3xQdVZCFAblxCEjXHZzfSVN5Qfykb86OpU7qY4HKhEZyn6WNMjgoufQlfdyWAjCHZc5E/DgWZ3cHGTTozr/hY=" May 10 19:32:01 volumio2 go-librespot[11997]: time="2025-05-10T19:32:01+07:00" 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]" May 10 19:32:01 volumio2 go-librespot[11997]: time="2025-05-10T19:32:01+07:00" level=debug msg="completed keyexchange" May 10 19:32:01 volumio2 go-librespot[11997]: time="2025-05-10T19:32:01+07:00" level=debug msg="completed challenge" May 10 19:32:01 volumio2 go-librespot[11997]: time="2025-05-10T19:32:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:01 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:01 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:02 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:02 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:04 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:04 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351351. May 10 19:32:04 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:04 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:04 volumio2 go-librespot[12004]: Librespot-go daemon starting... May 10 19:32:04 volumio2 go-librespot[12004]: time="2025-05-10T19:32:04+07:00" level=info msg="generated new device id: d1d7017bfcc6dafa828bce5affb2df3b9b62fff9" May 10 19:32:04 volumio2 go-librespot[12004]: time="2025-05-10T19:32:04+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:05 volumio2 go-librespot[12004]: time="2025-05-10T19:32:05+07:00" level=debug msg="obtained new client token: AACBENaWeZ8+8+zpQf2GoF00ISs/Z7l7xylfcKxo8sEgWjqsO8tLyEM8F2iq/x5IHzUAlRU5BXRY+vRnkiv2W5RnfLAtMf4JTXqEDNwGQsjBDbDQtAl9F7iKKiZ3k10cq4ai3w4ZZ+hlSzbDOYfT1AFG8zhj0W4A5l0FLTp7uSgUclIfAhQlmg1gWPx/QxWPxK0XS+sGTU07kf8rkyYEBPzvYXYFGDFRdzxkZLXDdQt+UgJgLMNPrnBQKV7z" May 10 19:32:05 volumio2 go-librespot[12004]: time="2025-05-10T19:32:05+07:00" 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]" May 10 19:32:05 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:05 volumio2 go-librespot[12004]: time="2025-05-10T19:32:05+07:00" level=debug msg="new websocket client" May 10 19:32:05 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:32:08 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:32:08 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 10 19:32:08 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:08 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:09 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:09 volumio2 volumio[1015]: verbose: New Socket.io Connection to 192.168.1.180:3000 from 192.168.1.221 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 10 19:32:09 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 10 19:32:10 volumio2 go-librespot[12004]: time="2025-05-10T19:32:10+07:00" level=debug msg="completed keyexchange" May 10 19:32:10 volumio2 go-librespot[12004]: time="2025-05-10T19:32:10+07:00" level=debug msg="completed challenge" May 10 19:32:10 volumio2 go-librespot[12004]: time="2025-05-10T19:32:10+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:10 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: socket hang up May 10 19:32:10 volumio2 volumio[1015]: at connResetException (internal/errors.js:639:14) May 10 19:32:10 volumio2 volumio[1015]: at Socket.socketOnEnd (_http_client.js:499:23) May 10 19:32:10 volumio2 volumio[1015]: at Socket.emit (events.js:412:35) May 10 19:32:10 volumio2 volumio[1015]: at endReadableNT (internal/streams/readable.js:1333:12) May 10 19:32:10 volumio2 volumio[1015]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 10 19:32:10 volumio2 volumio[1015]: (node:1015) 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: 78906) May 10 19:32:10 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:32:10 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:10 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:11 volumio2 sudo[12030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 10 19:32:11 volumio2 sudo[12030]: pam_unix(sudo:session): session opened for user root by (uid=0) May 10 19:32:11 volumio2 sudo[12030]: pam_unix(sudo:session): session closed for user root May 10 19:32:11 volumio2 sudo[12033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 10 19:32:11 volumio2 sudo[12033]: pam_unix(sudo:session): session opened for user root by (uid=0) May 10 19:32:11 volumio2 sudo[12033]: pam_unix(sudo:session): session closed for user root May 10 19:32:11 volumio2 volumio[1015]: verbose: New Socket.io Connection to 192.168.1.180 from 192.168.1.221 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetVisibleSources May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 10 19:32:11 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 10 19:32:11 volumio2 sudo[12036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 10 19:32:11 volumio2 sudo[12036]: pam_unix(sudo:session): session opened for user root by (uid=0) May 10 19:32:11 volumio2 sudo[12036]: pam_unix(sudo:session): session closed for user root May 10 19:32:11 volumio2 sudo[12039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 10 19:32:11 volumio2 sudo[12039]: pam_unix(sudo:session): session opened for user root by (uid=0) May 10 19:32:11 volumio2 sudo[12039]: pam_unix(sudo:session): session closed for user root May 10 19:32:11 volumio2 volumio[1015]: verbose: New Socket.io Connection to 192.168.1.180 from 192.168.1.221 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 10 19:32:12 volumio2 volumio[1015]: info: Listing playlists May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 10 19:32:12 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:13 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetVisibleSources May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 10 19:32:13 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetQueue May 10 19:32:13 volumio2 volumio[1015]: info: CoreStateMachine::getQueue May 10 19:32:13 volumio2 volumio[1015]: info: CorePlayQueue::getQueue May 10 19:32:13 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:13 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:13 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:13 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351352. May 10 19:32:13 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:13 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:13 volumio2 go-librespot[12041]: Librespot-go daemon starting... May 10 19:32:13 volumio2 go-librespot[12041]: time="2025-05-10T19:32:13+07:00" level=info msg="generated new device id: 6a69481ca19882b2b9ef940e65017b502b548284" May 10 19:32:13 volumio2 go-librespot[12041]: time="2025-05-10T19:32:13+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:14 volumio2 go-librespot[12041]: time="2025-05-10T19:32:14+07:00" level=debug msg="obtained new client token: AABNuDnHh1n8b22u4DvZ+ZmnESymV3X1M10ejL78pZYRWWTAcXVG22Lv7ZkvYImpHFGXfWKAWyHpEfKDemvkLKMgv90r4hEHXDf4Ww7xaKh1kAY57WxNzBDp3kGvVF+6JSEx/hQrq7LTKNghG30Cv87CX80lXtcUYS523xRYVy2hqTEHhyROj6/uYZgLrI0rL9RlnZ1RDAPxg4g9Z3gAQ4iwYc0X4FIUKKIuRTGlfajFtgQ7aOjDhA1hz7mQ" May 10 19:32:14 volumio2 go-librespot[12041]: time="2025-05-10T19:32:14+07:00" 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]" May 10 19:32:14 volumio2 go-librespot[12041]: time="2025-05-10T19:32:14+07:00" level=debug msg="completed keyexchange" May 10 19:32:14 volumio2 go-librespot[12041]: time="2025-05-10T19:32:14+07:00" level=debug msg="completed challenge" May 10 19:32:14 volumio2 go-librespot[12041]: time="2025-05-10T19:32:14+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:14 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:14 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 10 19:32:16 volumio2 volumio[1015]: info: Received Get System Info May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:16 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 10 19:32:16 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 10 19:32:16 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:16 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:17 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 10 19:32:17 volumio2 volumio[1015]: info: Received Get System Info May 10 19:32:17 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:17 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:17 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:17 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:17 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:17 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:17 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351353. May 10 19:32:17 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:17 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:17 volumio2 go-librespot[12052]: Librespot-go daemon starting... May 10 19:32:17 volumio2 go-librespot[12052]: time="2025-05-10T19:32:17+07:00" level=info msg="generated new device id: 173773a4aedb2d3ce8ac766148970064aed060ed" May 10 19:32:17 volumio2 go-librespot[12052]: time="2025-05-10T19:32:17+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:18 volumio2 go-librespot[12052]: time="2025-05-10T19:32:18+07:00" level=debug msg="obtained new client token: AAC4QSF2tm7EKhDSXadU2Tei9q/hyRJc5wRJE1YePALzNAbY4EkKQjJjWvOQYr8sJmcNMWDjHvqvlqAZt3jzG3crSqIuow8AFOXjqHRnnOCWIjPngTsSH86/pUGotm/4t/dXrx49YoHqLMCGCGOzRLw69as6UMuBAMPA4rcaUbiVxVVKeRtush2jtHvjaw6BEBed0PbOr694az3EhQ4M7jjkbZt0cfwfuFrSoe1O2wIkVOvszlqoqXdil+mk" May 10 19:32:18 volumio2 go-librespot[12052]: time="2025-05-10T19:32:18+07:00" 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]" May 10 19:32:18 volumio2 go-librespot[12052]: time="2025-05-10T19:32:18+07:00" level=debug msg="completed keyexchange" May 10 19:32:18 volumio2 go-librespot[12052]: time="2025-05-10T19:32:18+07:00" level=debug msg="completed challenge" May 10 19:32:18 volumio2 go-librespot[12052]: time="2025-05-10T19:32:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:18 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:18 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: info: Retrieving Cloud Streaming UI May 10 19:32:19 volumio2 volumio[1015]: info: Getting Tidal Cloud Configuration May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: info: Getting Qobuz Cloud Configuration May 10 19:32:19 volumio2 volumio[1015]: info: Asking plugin for UI Config May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: info: Getting Spotify Cloud Configuration May 10 19:32:19 volumio2 volumio[1015]: info: Asking plugin for UI Config May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: info: Saving Spotify Acccount May 10 19:32:19 volumio2 volumio[1015]: info: Got Tidal Cloud Configuration May 10 19:32:19 volumio2 volumio[1015]: info: Got it May 10 19:32:19 volumio2 volumio[1015]: info: Got it May 10 19:32:19 volumio2 volumio[1015]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::getUIConfigOnPlugin May 10 19:32:19 volumio2 volumio[1015]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetBrowseSources May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetBrowseSources May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetBrowseSources May 10 19:32:19 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:19 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:19 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 10 19:32:22 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:22 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351354. May 10 19:32:22 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:22 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:22 volumio2 go-librespot[12074]: Librespot-go daemon starting... May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" level=info msg="generated new device id: 4bc556193df3df46f229617840e46d16816ba8fd" May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" level=debug msg="obtained new client token: AABvPp14/nAvDR8l0IYnk3HtML4vMkg63E+qBrHGlzMxlU5wugWD9oCnaYJUlAKLCnAidef9xepTAzOnjjeiY0ns5Lyc3sBB0L2OEKPrXHujwJSvGpm9Du2xsMcH/02UaQdDI4De0wt3QbT29yTE/O91IevzxT+l0GyVOGRVCv1dwJKDbXY4ldw2AbdLjbE35nJpkQC8uXHKnwYFmk8Zmzu1qSTYQ+Vo7ZaerToUmsjI8HRs5P0N9nrGNERpcmM=" May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" 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]" May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" level=debug msg="completed keyexchange" May 10 19:32:22 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:22 volumio2 go-librespot[12074]: time="2025-05-10T19:32:22+07:00" level=debug msg="new websocket client" May 10 19:32:22 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:32:23 volumio2 go-librespot[12074]: time="2025-05-10T19:32:23+07:00" level=debug msg="completed challenge" May 10 19:32:23 volumio2 go-librespot[12074]: time="2025-05-10T19:32:23+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:23 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:32:23 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:23 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:23 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:25 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:32:25 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:25 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:32:25 volumio2 volumio[1015]: (node:1015) 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: 78907) May 10 19:32:25 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 10 19:32:25 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:25 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:32:26 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:26 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:26 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:26 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351355. May 10 19:32:26 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:26 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:26 volumio2 go-librespot[12081]: Librespot-go daemon starting... May 10 19:32:26 volumio2 go-librespot[12081]: time="2025-05-10T19:32:26+07:00" level=info msg="generated new device id: 2103a6bbcbdace81ea5f65b92cd9257adea98f48" May 10 19:32:26 volumio2 go-librespot[12081]: time="2025-05-10T19:32:26+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:26 volumio2 go-librespot[12081]: time="2025-05-10T19:32:26+07:00" level=debug msg="obtained new client token: AACqwbCRhcn5WN70IZn+REZZgDVAECVFjh26zST2bnd8SdHFB2fISQKxZw21FT0/j9Q5XaShaMC1TzRtyqe2W/Omrz5ocX0pt3YQo29qaYaUfY4AMwnZudfjjy/oLv38t1cqR6+lm+FJssFddkhMYkAu/D6Fet4jkxhzeT2F8YEQk1KLshlr+EqtAL1m0tPS++LR6Rb1+MrtV72fLtmIDwm6zThpouihDgKVtbb+L3KkdTMPmEz9DNpZBp1w+2c=" May 10 19:32:26 volumio2 go-librespot[12081]: time="2025-05-10T19:32:26+07:00" 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]" May 10 19:32:26 volumio2 go-librespot[12081]: time="2025-05-10T19:32:26+07:00" level=debug msg="completed keyexchange" May 10 19:32:27 volumio2 go-librespot[12081]: time="2025-05-10T19:32:27+07:00" level=debug msg="completed challenge" May 10 19:32:27 volumio2 go-librespot[12081]: time="2025-05-10T19:32:27+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:27 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:27 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:27 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:29 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:29 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:30 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:30 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351356. May 10 19:32:30 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:30 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:30 volumio2 go-librespot[12106]: Librespot-go daemon starting... May 10 19:32:30 volumio2 go-librespot[12106]: time="2025-05-10T19:32:30+07:00" level=info msg="generated new device id: 81fb4262255db1fffc51a3bee86b2cd75048249e" May 10 19:32:30 volumio2 go-librespot[12106]: time="2025-05-10T19:32:30+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:30 volumio2 go-librespot[12106]: time="2025-05-10T19:32:30+07:00" level=debug msg="obtained new client token: AADzR2uQ2sj38h26qU4pAcW1GGWfOT/Z419OtTrlzmmskFgmOfbKkLv4kJY2CajTUrfajG1wRaeVwBWbjMdvp78lL3nSVdZgJbAq+hEoHW1g2NAhfpagc9dkVU4sMiOBEqOjN3K1hu8oBqUmBgY5dtKD/G9+Me6F+GQKaDWJO9yMXoSBO7G2yDEkOEwJ8oPpwnS7OCqiyfrl4ZFryfJZAk0R+4aSnvVhsym9edWFhxYOX4QCK8pXJkGvMTBNehI=" May 10 19:32:30 volumio2 go-librespot[12106]: time="2025-05-10T19:32:30+07:00" 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]" May 10 19:32:30 volumio2 go-librespot[12106]: time="2025-05-10T19:32:30+07:00" level=debug msg="completed keyexchange" May 10 19:32:30 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 10 19:32:30 volumio2 volumio[1015]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 10 19:32:30 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 10 19:32:30 volumio2 volumio[1015]: info: Received Get System Version May 10 19:32:30 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 10 19:32:31 volumio2 volumio[1015]: info: Received Get System Info May 10 19:32:31 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:31 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:31 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:31 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:31 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:31 volumio2 go-librespot[12106]: time="2025-05-10T19:32:31+07:00" level=debug msg="completed challenge" May 10 19:32:31 volumio2 go-librespot[12106]: time="2025-05-10T19:32:31+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:31 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:31 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:31 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:32 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:32 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:34 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:34 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351357. May 10 19:32:34 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:34 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:34 volumio2 go-librespot[12157]: Librespot-go daemon starting... May 10 19:32:34 volumio2 go-librespot[12157]: time="2025-05-10T19:32:34+07:00" level=info msg="generated new device id: 2e2d8ad3c77ec4f86a79f8363be225fc413b56e0" May 10 19:32:34 volumio2 go-librespot[12157]: time="2025-05-10T19:32:34+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:34 volumio2 go-librespot[12157]: time="2025-05-10T19:32:34+07:00" level=debug msg="obtained new client token: AABrL3RWiA6hLjpJ37n5OC4VsFDWRw7KK21KqFZ/qb+8/ma9rIiQ1HWhoWBQmgOTF6BlrVZnwGphVx/DRlWAzA/qldlFpcxkOpCAipyYGZsk3mAQv0tFqJKvmj0dXzt3SNtXv6lC5SH1qiJFzIZJdUUtXodu4IdTKUQQKb0yLSG40RrfgnkrSgDuIK4AuD43XBxftqxshdXkRX8L5B+yR0pdl83uM4koTJcE233Z5Bo4Gjo8hlKkiMYInAANo1c=" May 10 19:32:34 volumio2 volumio[1015]: info: Disabling MyMusic plugin upnp May 10 19:32:34 volumio2 sudo[12165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 10 19:32:34 volumio2 sudo[12165]: pam_unix(sudo:session): session opened for user root by (uid=0) May 10 19:32:34 volumio2 systemd[1]: Stopping UPnP Renderer front-end to MPD... May 10 19:32:34 volumio2 volumio[1015]: error: Upnp client error: Error: This socket has been ended by the other party May 10 19:32:34 volumio2 go-librespot[12157]: time="2025-05-10T19:32:34+07:00" 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]" May 10 19:32:34 volumio2 go-librespot[12157]: time="2025-05-10T19:32:34+07:00" level=debug msg="completed keyexchange" May 10 19:32:35 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:35 volumio2 go-librespot[12157]: time="2025-05-10T19:32:35+07:00" level=debug msg="new websocket client" May 10 19:32:35 volumio2 volumio[1015]: info: Connection to go-librespot Websocket established May 10 19:32:35 volumio2 go-librespot[12157]: time="2025-05-10T19:32:35+07:00" level=debug msg="completed challenge" May 10 19:32:35 volumio2 go-librespot[12157]: time="2025-05-10T19:32:35+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:35 volumio2 volumio[1015]: info: Connection to go-librespot Websocket closed May 10 19:32:35 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:35 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:35 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:38 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 10 19:32:38 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 10 19:32:38 volumio2 volumio[1015]: info: Discovery: Getting this device information May 10 19:32:38 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:38 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 10 19:32:38 volumio2 volumio[1015]: info: Getting Spotify volume May 10 19:32:38 volumio2 volumio[1015]: (node:1015) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:38 volumio2 volumio[1015]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) May 10 19:32:38 volumio2 volumio[1015]: (node:1015) 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: 78908) May 10 19:32:38 volumio2 volumio[1015]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 10 19:32:38 volumio2 volumio[1015]: info: CoreCommandRouter::volumioGetState May 10 19:32:38 volumio2 volumio[1015]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 10 19:32:38 volumio2 volumio[1015]: info: Initializing connection to go-librespot Websocket May 10 19:32:38 volumio2 volumio[1015]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 10 19:32:38 volumio2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 10 19:32:38 volumio2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351358. May 10 19:32:38 volumio2 systemd[1]: Stopped go-librespot Daemon. May 10 19:32:38 volumio2 systemd[1]: Started go-librespot Daemon. May 10 19:32:38 volumio2 go-librespot[12167]: Librespot-go daemon starting... May 10 19:32:38 volumio2 go-librespot[12167]: time="2025-05-10T19:32:38+07:00" level=info msg="generated new device id: cff88c71d49af175225261adaf2289ed7d2d3bec" May 10 19:32:38 volumio2 go-librespot[12167]: time="2025-05-10T19:32:38+07:00" level=debug msg="stored credentials found for tp20pocsknlcll7n6w5hgfvb0" May 10 19:32:38 volumio2 go-librespot[12167]: time="2025-05-10T19:32:38+07:00" level=debug msg="obtained new client token: AADDl7EXAPLQXss5IXwSq7xkXFTxVonA1fKMe6U7Bmhkf3Ar5vzqEHXY/hpuuFfgUMAeNeBZa7WYsla4xe1icKLYj7KXMworFm9eW5b6SIt0ljDX3fSGwMhXvVn2WbD4iCDAqW0vvAjdHamEt+E0eozCiJ06lGDPuLQxDGsmJbixvjPcvwhI46JobvWa1dNV+7ivuxrgy3ZfX1BeaTV0zyc3JZmdPZ/EhIu1XBiignxyPiePW9Ni7Skr9GGsR9k=" May 10 19:32:38 volumio2 go-librespot[12167]: time="2025-05-10T19:32:38+07:00" 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]" May 10 19:32:38 volumio2 go-librespot[12167]: time="2025-05-10T19:32:38+07:00" level=debug msg="completed keyexchange" May 10 19:32:39 volumio2 go-librespot[12167]: time="2025-05-10T19:32:39+07:00" level=debug msg="completed challenge" May 10 19:32:39 volumio2 go-librespot[12167]: time="2025-05-10T19:32:39+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 10 19:32:39 volumio2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 10 19:32:39 volumio2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 10 19:32:39 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 10 19:32:41 volumio2 volumio[1015]: info: Enabling MyMusic plugin upnp May 10 19:32:41 volumio2 volumio[1015]: info: Enabling plugin upnp May 10 19:32:41 volumio2 volumio[1015]: info: Loading plugin "upnp"... May 10 19:32:41 volumio2 volumio[1015]: info: [1746880361025] Starting Upmpd Daemon May 10 19:32:41 volumio2 volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 10 19:32:41 volumio2 volumio[1015]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 10 19:32:41 volumio2 volumio[1015]: Error: listen EADDRINUSE: address already in use :::6599 May 10 19:32:41 volumio2 volumio[1015]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) May 10 19:32:41 volumio2 volumio[1015]: at listenInCluster (net.js:1379:12) May 10 19:32:41 volumio2 volumio[1015]: at Server.listen (net.js:1465:7) May 10 19:32:41 volumio2 volumio[1015]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 10 19:32:41 volumio2 volumio[1015]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 10 19:32:41 volumio2 volumio[1015]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 10 19:32:41 volumio2 volumio[1015]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 10 19:32:41 volumio2 volumio[1015]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { May 10 19:32:41 volumio2 volumio[1015]: code: 'EADDRINUSE', May 10 19:32:41 volumio2 volumio[1015]: errno: -98, May 10 19:32:41 volumio2 volumio[1015]: syscall: 'listen', May 10 19:32:41 volumio2 volumio[1015]: address: '::', May 10 19:32:41 volumio2 volumio[1015]: port: 6599 May 10 19:32:41 volumio2 volumio[1015]: } May 10 19:32:41 volumio2 volumio[1015]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 10 19:32:41 volumio2 sudo[12197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-10 19:31 May 10 19:32:41 volumio2 sudo[12197]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"