-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Sun 2025-10-26 20:58:29 CST. -- Oct 26 20:57:00 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:00 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Oct 26 20:57:00 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:00 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:00 volumio go-librespot[1969]: Librespot-go daemon starting... Oct 26 20:57:00 volumio go-librespot[1969]: time="2025-10-26T20:57:00+08:00" level=info msg="generated new device id: 73a907dce1fca36b899e893597f9d5e7e05b605d" Oct 26 20:57:00 volumio go-librespot[1969]: time="2025-10-26T20:57:00+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:01 volumio go-librespot[1969]: time="2025-10-26T20:57:01+08:00" level=debug msg="obtained new client token: AABTi5UhHk5vQ3lXJLvm5wbJA+0xICH/Fz8PgPQowSzjxQ2ia7a+BESApE6l1GzWgUM5VvF0HaPWLLR/wHUm5luuLJZCFrB6z2SzQQpMUL2CtBxdRE2k+sd/leEXYwDszKBA7hQvl92RtpHoYQTRJz6g1F3e24bNLKmaOby0Po52PhC6KE6P3w2vaxSXE+4Har59bguME+4Mc8B6lPjk0xVvSQ0tW802OkTxYbI/9AX1Y4lusk/uFm8Yw2fXwOvWrg==" Oct 26 20:57:02 volumio kernel: hwmon hwmon1: Voltage normalised Oct 26 20:57:02 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:03 volumio go-librespot[1969]: time="2025-10-26T20:57:03+08: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]" Oct 26 20:57:03 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:03 volumio go-librespot[1969]: time="2025-10-26T20:57:03+08:00" level=debug msg="new websocket client" Oct 26 20:57:03 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:05 volumio go-librespot[1969]: time="2025-10-26T20:57:05+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:06 volumio go-librespot[1969]: time="2025-10-26T20:57:06+08:00" level=debug msg="completed challenge" Oct 26 20:57:06 volumio go-librespot[1969]: time="2025-10-26T20:57:06+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:06 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:06 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:06 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:06 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:57:06 volumio volumio[921]: (node:921) 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: 11) Oct 26 20:57:06 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Oct 26 20:57:06 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:06 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:08 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:09 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:09 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:09 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Oct 26 20:57:09 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:09 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:09 volumio go-librespot[1978]: Librespot-go daemon starting... Oct 26 20:57:09 volumio go-librespot[1978]: time="2025-10-26T20:57:09+08:00" level=info msg="generated new device id: e1a66dd59d176ba8686d17f9b034b3d343bd56c8" Oct 26 20:57:09 volumio go-librespot[1978]: time="2025-10-26T20:57:09+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:11 volumio go-librespot[1978]: time="2025-10-26T20:57:11+08:00" level=debug msg="obtained new client token: AAAohGDAdb84b6/kg+fQC3cuiOFvxNV/j42AN53k/CeyZbjRNbI8rKtJYtMQxI8t9aQg0Wj4LFeN4ac9sc9t8kfs3E9diJlHB6kG8lPGyniWr2vYDC26aJ056+62t7CNYX54CDUx3Tb3v2N/JpxmyANMZeh3r2MMIUMGQuJaG6cUCjOqRwPGQJCeSDVLwj+f4MZJryBeVCk43lUxoaVyy1MtJ202ZCP91Dfm7E/nN9UGWnVn4bKLvXY0xxDuqo/ltg==" Oct 26 20:57:12 volumio go-librespot[1978]: time="2025-10-26T20:57:12+08: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]" Oct 26 20:57:12 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:12 volumio go-librespot[1978]: time="2025-10-26T20:57:12+08:00" level=debug msg="new websocket client" Oct 26 20:57:12 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:14 volumio go-librespot[1978]: time="2025-10-26T20:57:14+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:14 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:15 volumio go-librespot[1978]: time="2025-10-26T20:57:15+08:00" level=debug msg="completed challenge" Oct 26 20:57:15 volumio go-librespot[1978]: time="2025-10-26T20:57:15+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:15 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:15 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:15 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:15 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:57:15 volumio volumio[921]: (node:921) 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: 12) Oct 26 20:57:15 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Oct 26 20:57:15 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:15 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:18 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:18 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Oct 26 20:57:18 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:18 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:18 volumio go-librespot[1988]: Librespot-go daemon starting... Oct 26 20:57:18 volumio go-librespot[1988]: time="2025-10-26T20:57:18+08:00" level=info msg="generated new device id: cd83a7131b22ab1c1e960652805cc59eb3deda45" Oct 26 20:57:18 volumio go-librespot[1988]: time="2025-10-26T20:57:18+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:19 volumio go-librespot[1988]: time="2025-10-26T20:57:19+08:00" level=debug msg="obtained new client token: AACH4SVC68j9UhkxFHvOgSz9B01/U0zZLZ8JpEsX3J6RzK4LcJUjIUzs7qbjmjcDF6BFWMXW6v9cEHHmrSYUFMj0X3HHZiUXteRF3AFd56B1tyBCV2gczEiRYos5vb6dzYNP8hvFJG3Hvk2ZPkPc8gDcUGZ1CiGHTzKrjLnCi7C5p18Ea+c3h0G1ihudv1uR1qd94ugtgTo/a3DkTPi+lWHh6F8ll8KMjju2FuBpL1+O9uAgRx4f1Lp5rC4N/bLdmA==" Oct 26 20:57:20 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:21 volumio go-librespot[1988]: time="2025-10-26T20:57:21+08: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]" Oct 26 20:57:21 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:21 volumio go-librespot[1988]: time="2025-10-26T20:57:21+08:00" level=debug msg="new websocket client" Oct 26 20:57:21 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:21 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 9 Oct 26 20:57:21 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 10 Oct 26 20:57:21 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 11 Oct 26 20:57:21 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 12 Oct 26 20:57:21 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 13 Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:21 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:21 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetQueue Oct 26 20:57:21 volumio volumio[921]: info: CoreStateMachine::getQueue Oct 26 20:57:21 volumio volumio[921]: info: CorePlayQueue::getQueue Oct 26 20:57:21 volumio volumio[921]: info: Listing playlists Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 20:57:21 volumio volumio[921]: info: Received Get System Info Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 20:57:21 volumio volumio[921]: info: Discovery: Getting this device information Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:21 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 20:57:21 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:21 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:22 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 20:57:22 volumio sudo[2038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 20:57:22 volumio sudo[2038]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 20:57:22 volumio sudo[2038]: pam_unix(sudo:session): session closed for user root Oct 26 20:57:22 volumio sudo[2041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 20:57:22 volumio sudo[2041]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 20:57:22 volumio sudo[2041]: pam_unix(sudo:session): session closed for user root Oct 26 20:57:22 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 14 Oct 26 20:57:23 volumio sudo[2044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 20:57:23 volumio sudo[2044]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 20:57:23 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:23 volumio sudo[2044]: pam_unix(sudo:session): session closed for user root Oct 26 20:57:23 volumio sudo[2047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 20:57:23 volumio sudo[2047]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 20:57:23 volumio sudo[2047]: pam_unix(sudo:session): session closed for user root Oct 26 20:57:23 volumio go-librespot[1988]: time="2025-10-26T20:57:23+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:23 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 15 Oct 26 20:57:23 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:23 volumio go-librespot[1988]: time="2025-10-26T20:57:23+08:00" level=debug msg="completed challenge" Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 20:57:24 volumio go-librespot[1988]: time="2025-10-26T20:57:24+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:24 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetQueue Oct 26 20:57:24 volumio volumio[921]: info: CoreStateMachine::getQueue Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getQueue Oct 26 20:57:24 volumio volumio[921]: info: Listing playlists Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 20:57:24 volumio volumio[921]: info: Received Get System Info Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 20:57:24 volumio volumio[921]: info: Discovery: Getting this device information Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 20:57:24 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:24 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:24 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:57:24 volumio volumio[921]: (node:921) 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: 13) Oct 26 20:57:24 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 16 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:24 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:24 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 20:57:26 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 20:57:26 volumio volumio[921]: info: Received Get System Info Oct 26 20:57:26 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 20:57:26 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 20:57:26 volumio volumio[921]: info: Discovery: Getting this device information Oct 26 20:57:26 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:26 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:26 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 20:57:26 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:27 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:27 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:27 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Oct 26 20:57:27 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:27 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:27 volumio go-librespot[2049]: Librespot-go daemon starting... Oct 26 20:57:27 volumio go-librespot[2049]: time="2025-10-26T20:57:27+08:00" level=info msg="generated new device id: 102f1bf9bcf00ca62a6f72c0cf6add08a4d7314a" Oct 26 20:57:27 volumio go-librespot[2049]: time="2025-10-26T20:57:27+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:29 volumio go-librespot[2049]: time="2025-10-26T20:57:29+08:00" level=debug msg="obtained new client token: AAB7WnrfqaV4TkYw6AUq6WzBnxTB5ATtJInEPTDJpQ6Wa4x7gZg+QTKMxslzoyleeJUZ3RjOIwi0hYcMrUfGmD3GBcmm32fKFYt19v569f2p6DlPjSiiJNJ0CPTJaWkxTHvV0V9u1wMO0fL4KcxVaYXfHUIabOaao7A4wWX/trMfQuVRrR67hQrR9/VBTQH+oQBUDO7tFUpVIcieGi9Ujz8bC1UFntT23f9FC3uF5FmI1n6AWqRE0WCXoxpuPfU=" Oct 26 20:57:30 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:30 volumio go-librespot[2049]: time="2025-10-26T20:57:30+08:00" level=debug msg="new websocket client" Oct 26 20:57:30 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:30 volumio go-librespot[2049]: time="2025-10-26T20:57:30+08: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]" Oct 26 20:57:32 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:32 volumio go-librespot[2049]: time="2025-10-26T20:57:32+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:33 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:33 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:57:33 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:33 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:33 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:33 volumio go-librespot[2049]: time="2025-10-26T20:57:33+08:00" level=debug msg="completed challenge" Oct 26 20:57:33 volumio go-librespot[2049]: time="2025-10-26T20:57:33+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:33 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: socket hang up Oct 26 20:57:33 volumio volumio[921]: at connResetException (internal/errors.js:607:14) Oct 26 20:57:33 volumio volumio[921]: at Socket.socketOnEnd (_http_client.js:493:23) Oct 26 20:57:33 volumio volumio[921]: at Socket.emit (events.js:327:22) Oct 26 20:57:33 volumio volumio[921]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 26 20:57:33 volumio volumio[921]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 26 20:57:33 volumio volumio[921]: (node:921) 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: 14) Oct 26 20:57:33 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:36 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:36 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:36 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Oct 26 20:57:36 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:36 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:36 volumio go-librespot[2058]: Librespot-go daemon starting... Oct 26 20:57:36 volumio go-librespot[2058]: time="2025-10-26T20:57:36+08:00" level=info msg="generated new device id: fe5df651503eb8554721290fe2f4a464d363d8cf" Oct 26 20:57:36 volumio go-librespot[2058]: time="2025-10-26T20:57:36+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:38 volumio go-librespot[2058]: time="2025-10-26T20:57:38+08:00" level=debug msg="obtained new client token: AAD+6KS33VaNCPUge0COKmUxy2IAoteE/Dfg3iOesflGnRWxbr32x6CqX+DZv49CtveoOO8EzGQ/lBfm8pxvdIkI2q+CiuX1zZHWHV/PGNJ0m14dRn1oEgYXjuis4hN10DXQcBY0m0GCLK7Tv8Dh7EhTBosgytHWTQa4slONkCQgjUHwTN4QfSD4/nIyPNqJ9xkTclOrkGMBQv0NobS8GqWH9nOKZYc9+mcOTLG6+PC2+PUAnormLL4j7+r8EII=" Oct 26 20:57:38 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:39 volumio go-librespot[2058]: time="2025-10-26T20:57:39+08: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]" Oct 26 20:57:39 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:39 volumio go-librespot[2058]: time="2025-10-26T20:57:39+08:00" level=debug msg="new websocket client" Oct 26 20:57:39 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:41 volumio go-librespot[2058]: time="2025-10-26T20:57:41+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:42 volumio go-librespot[2058]: time="2025-10-26T20:57:42+08:00" level=debug msg="completed challenge" Oct 26 20:57:42 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:42 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:57:42 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:42 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:42 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:42 volumio go-librespot[2058]: time="2025-10-26T20:57:42+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:42 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: socket hang up Oct 26 20:57:42 volumio volumio[921]: at connResetException (internal/errors.js:607:14) Oct 26 20:57:42 volumio volumio[921]: at Socket.socketOnEnd (_http_client.js:493:23) Oct 26 20:57:42 volumio volumio[921]: at Socket.emit (events.js:327:22) Oct 26 20:57:42 volumio volumio[921]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 26 20:57:42 volumio volumio[921]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 26 20:57:42 volumio volumio[921]: (node:921) 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: 15) Oct 26 20:57:42 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:44 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:45 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:45 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:45 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Oct 26 20:57:45 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:45 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:45 volumio go-librespot[2067]: Librespot-go daemon starting... Oct 26 20:57:45 volumio go-librespot[2067]: time="2025-10-26T20:57:45+08:00" level=info msg="generated new device id: a5801e9ff965ac1e40172fed78089d4b76c523e2" Oct 26 20:57:45 volumio go-librespot[2067]: time="2025-10-26T20:57:45+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:46 volumio go-librespot[2067]: time="2025-10-26T20:57:46+08:00" level=debug msg="obtained new client token: AAD58nfHnRWLU16eDSCl4nF8hPfd0zzZ4hvjy1k4qCuG9rYFqZXkPB7+NL7zqyvU2jtO0TthyTiQRsQAGIfkBNiS+ZecqJuj4StvDACgaXEDWYJLYCA1T+2Zszln5GxBkz6UAMxQhYR+/HN5JK+mndWdCafn12CsA5ZOZ65vW7Smk/4wNe/hfP2wwvUyoTlhMKXg5o5rp1Elqn7R9l6Gf/UQb3PLbq8IsA4Tm2BA0bMYGSTEULPwzX47wtq9thgGZA==" Oct 26 20:57:48 volumio go-librespot[2067]: time="2025-10-26T20:57:48+08: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]" Oct 26 20:57:48 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:48 volumio go-librespot[2067]: time="2025-10-26T20:57:48+08:00" level=debug msg="new websocket client" Oct 26 20:57:48 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:50 volumio go-librespot[2067]: time="2025-10-26T20:57:50+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:50 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:51 volumio go-librespot[2067]: time="2025-10-26T20:57:51+08:00" level=debug msg="completed challenge" Oct 26 20:57:51 volumio go-librespot[2067]: time="2025-10-26T20:57:51+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:57:51 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:51 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:57:51 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:51 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:57:51 volumio volumio[921]: (node:921) 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: 17) Oct 26 20:57:51 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:57:51 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:57:51 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:57:51 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:57:54 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:54 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:57:54 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:57:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Oct 26 20:57:54 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:57:54 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:57:54 volumio go-librespot[2076]: Librespot-go daemon starting... Oct 26 20:57:54 volumio go-librespot[2076]: time="2025-10-26T20:57:54+08:00" level=info msg="generated new device id: 0e9dd4c77c50987ec68488d9d4ea657b03691e59" Oct 26 20:57:54 volumio go-librespot[2076]: time="2025-10-26T20:57:54+08:00" level=debug msg="stored credentials not found" Oct 26 20:57:55 volumio go-librespot[2076]: time="2025-10-26T20:57:55+08:00" level=debug msg="obtained new client token: AACLDIAFxQDmk5oQmOlLXu5+4a4KDtlfZEW9waBmvYdPFKSdsmvb6VKf0tzX0WH3Vs9HRR1VCHycdAiMAZ9x3ckaAz+9Pc+snecCLoZnTBg38V8VsBB2UEnSLNVjfwqdC3Q1Dg6NRy0pK07I4X8wRqDU4qXbMCzBIdhc/sCyXo9unOG1Z5BNI3XEKwWr0fVJ6tnsNORcn/sbbU9Gk6UlvfQKW9pxhtYaF9I6OZdDYqJVHlvEIKztlpOmhbP8umK/Qw==" Oct 26 20:57:56 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:57:57 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:57:57 volumio go-librespot[2076]: time="2025-10-26T20:57:57+08:00" level=debug msg="new websocket client" Oct 26 20:57:57 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:57:57 volumio go-librespot[2076]: time="2025-10-26T20:57:57+08: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]" Oct 26 20:57:58 volumio go-librespot[2076]: time="2025-10-26T20:57:58+08:00" level=debug msg="completed keyexchange" Oct 26 20:57:58 volumio go-librespot[2076]: time="2025-10-26T20:57:58+08:00" level=debug msg="completed challenge" Oct 26 20:57:59 volumio go-librespot[2076]: time="2025-10-26T20:57:59+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:57:59 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:57:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:57:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:58:00 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:58:00 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:00 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:58:00 volumio volumio[921]: (node:921) 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: 18) Oct 26 20:58:00 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:58:00 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:00 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:00 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:58:02 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:02 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:58:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Oct 26 20:58:02 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:58:02 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:58:02 volumio go-librespot[2086]: Librespot-go daemon starting... Oct 26 20:58:02 volumio go-librespot[2086]: time="2025-10-26T20:58:02+08:00" level=info msg="generated new device id: 2df9e892f4cae13e56e7c742ff6ffc31ecc2231d" Oct 26 20:58:02 volumio go-librespot[2086]: time="2025-10-26T20:58:02+08:00" level=debug msg="stored credentials not found" Oct 26 20:58:02 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:58:03 volumio go-librespot[2086]: time="2025-10-26T20:58:03+08:00" level=debug msg="obtained new client token: AABcM9WwTjK0X0TdCRm1stlO7ynA1C4qbzGeHapJJ1sY8fnl+BbCHkmKzRkOg1vPnh8FzyjXvQuvL1fJ0nIRUvdRHp7joVO3IDqaLHUHu8HAWgF/ucqMS1lJNGU7IM4bKOCvz58pINAQAzII5DsNAenbh7rLdT/+l4kxSBnGRyKGzncbEkbH/QCfH64V2tUjcEuIQImGzGiQWz9v0y6QolfHdTlkrlRhltFak1nvQRwC60AjSwEXPO4axi28Plg=" Oct 26 20:58:04 volumio go-librespot[2086]: time="2025-10-26T20:58:04+08: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]" Oct 26 20:58:05 volumio go-librespot[2086]: time="2025-10-26T20:58:05+08:00" level=debug msg="completed keyexchange" Oct 26 20:58:05 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:05 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:58:05 volumio go-librespot[2086]: time="2025-10-26T20:58:05+08:00" level=debug msg="new websocket client" Oct 26 20:58:05 volumio go-librespot[2086]: time="2025-10-26T20:58:05+08:00" level=debug msg="completed challenge" Oct 26 20:58:05 volumio go-librespot[2086]: time="2025-10-26T20:58:05+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:58:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:58:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:58:05 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:58:08 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:58:08 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:08 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:58:08 volumio volumio[921]: (node:921) 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: 19) Oct 26 20:58:08 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:58:08 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:08 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:08 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:58:08 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:58:08 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:08 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:08 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:58:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Oct 26 20:58:08 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:58:08 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:58:08 volumio go-librespot[2094]: Librespot-go daemon starting... Oct 26 20:58:08 volumio go-librespot[2094]: time="2025-10-26T20:58:08+08:00" level=info msg="generated new device id: 9b08fa30fcca57a2df6b15985c8c52423df7962f" Oct 26 20:58:08 volumio go-librespot[2094]: time="2025-10-26T20:58:08+08:00" level=debug msg="stored credentials not found" Oct 26 20:58:09 volumio go-librespot[2094]: time="2025-10-26T20:58:09+08:00" level=debug msg="obtained new client token: AAAd5f6vPPHq/Bm58hICt18ul2F1p8yYD9O0chpeeLHp9hI/crMimO4XScaj6Ku14x/0CBn76qh6CzMDpra5UTJvDm/eFTPuRmg7ELTt0qD6IZTHAcvB3BHkbqw0Hq4pYMrGNT2GV6fkF1GEDTM5ChBjkUjupUldUODHArUGAd7KvF6Dkr5zzeyUHo7VDsnjQlf4/970s8eK9D9Oial9PJ5EerWwsJJYN8FpfSGCXKb4wyPXUcSjcwIhC8uPNWwpyQ==" Oct 26 20:58:11 volumio go-librespot[2094]: time="2025-10-26T20:58:11+08: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]" Oct 26 20:58:11 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:11 volumio go-librespot[2094]: time="2025-10-26T20:58:11+08:00" level=debug msg="new websocket client" Oct 26 20:58:11 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:58:13 volumio go-librespot[2094]: time="2025-10-26T20:58:13+08:00" level=debug msg="completed keyexchange" Oct 26 20:58:14 volumio go-librespot[2094]: time="2025-10-26T20:58:14+08:00" level=debug msg="completed challenge" Oct 26 20:58:14 volumio go-librespot[2094]: time="2025-10-26T20:58:14+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:58:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:58:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:58:14 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:58:14 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:58:14 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:58:14 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:14 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:58:14 volumio volumio[921]: (node:921) 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: 20) Oct 26 20:58:14 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:58:14 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:14 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:14 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:58:17 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:17 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:17 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:58:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Oct 26 20:58:17 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:58:17 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:58:17 volumio go-librespot[2103]: Librespot-go daemon starting... Oct 26 20:58:17 volumio go-librespot[2103]: time="2025-10-26T20:58:17+08:00" level=info msg="generated new device id: f92ca62c883c10e59cd62e82e136e43ca8988ad4" Oct 26 20:58:17 volumio go-librespot[2103]: time="2025-10-26T20:58:17+08:00" level=debug msg="stored credentials not found" Oct 26 20:58:18 volumio go-librespot[2103]: time="2025-10-26T20:58:18+08:00" level=debug msg="obtained new client token: AACyKzusg5Xo1lZeaL89MOPX+iJTTBcbK8bIFbTWldr2kUdDmUaiUKL3/BbwHT+5hIH3GDUAmKC1CQqHJVfdzJRXmWcLkJFXhkmSQ1gp9avndUS28tzVpKD0xwYZo8dp6bIZBmEfJZowurYwQRbJC1qivzKZTUrGOxb/7YkPSUGZ7L7ySL97Z+sfRIfX34iU5iW0AdogN30PGU3v6Om0d9rTQ4XszAMPzX4Gwwr7rOj6Aqi2c862CYZJ0J1WXRm3Tw==" Oct 26 20:58:19 volumio go-librespot[2103]: time="2025-10-26T20:58:19+08: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]" Oct 26 20:58:20 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:20 volumio go-librespot[2103]: time="2025-10-26T20:58:20+08:00" level=debug msg="new websocket client" Oct 26 20:58:20 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:58:20 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:58:22 volumio go-librespot[2103]: time="2025-10-26T20:58:22+08:00" level=debug msg="completed keyexchange" Oct 26 20:58:22 volumio go-librespot[2103]: time="2025-10-26T20:58:22+08:00" level=debug msg="completed challenge" Oct 26 20:58:23 volumio go-librespot[2103]: time="2025-10-26T20:58:23+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" Oct 26 20:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 20:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 20:58:23 volumio volumio[921]: info: Connection to go-librespot Websocket closed Oct 26 20:58:23 volumio volumio[921]: info: Getting Spotify volume Oct 26 20:58:23 volumio volumio[921]: (node:921) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:23 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 26 20:58:23 volumio volumio[921]: (node:921) 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: 21) Oct 26 20:58:23 volumio volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Oct 26 20:58:23 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:23 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Oct 26 20:58:26 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:26 volumio volumio[921]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 20:58:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 26 20:58:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Oct 26 20:58:26 volumio systemd[1]: Stopped go-librespot Daemon. Oct 26 20:58:26 volumio systemd[1]: Started go-librespot Daemon. Oct 26 20:58:26 volumio go-librespot[2152]: Librespot-go daemon starting... Oct 26 20:58:26 volumio go-librespot[2152]: time="2025-10-26T20:58:26+08:00" level=info msg="generated new device id: 3d8861940653cf2835252825742d3d552609b0b7" Oct 26 20:58:26 volumio go-librespot[2152]: time="2025-10-26T20:58:26+08:00" level=debug msg="stored credentials not found" Oct 26 20:58:26 volumio wpa_supplicant[762]: wlan0: Failed to initiate sched scan Oct 26 20:58:27 volumio go-librespot[2152]: time="2025-10-26T20:58:27+08:00" level=debug msg="obtained new client token: AAB7YT5+Df4Pluh+/VZcUHJPpCNoYoyCUw2Yc40agvGLTaqzWFTUvXRfMy/asJ9xbXw2q+2AvFfFS80Qhv8oZQkY/r9VKIAIQanYIPTX4yt+/zIGYzmk/SRUFHSpOWhdUDXET7/0096+7lcj//L59J+RuarYbjObulPoT4fiGArByKtJsMjlevW1tkPOCakKb+C7MJk0p35t/+f2n03GZ/W9zPe1/eWlV7BiYlQxMasOdg9veHzZ3lJbrPu7OiQ=" Oct 26 20:58:28 volumio go-librespot[2152]: time="2025-10-26T20:58:28+08: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]" Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 13 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 14 Oct 26 20:58:28 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 15 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 16 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 17 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 18 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 19 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 20 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 21 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 22 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 23 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 24 Oct 26 20:58:28 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 25 Oct 26 20:58:28 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 26 Oct 26 20:58:29 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 27 Oct 26 20:58:29 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 28 Oct 26 20:58:29 volumio volumio[921]: info: Initializing connection to go-librespot Websocket Oct 26 20:58:29 volumio go-librespot[2152]: time="2025-10-26T20:58:29+08:00" level=debug msg="new websocket client" Oct 26 20:58:29 volumio volumio[921]: info: Connection to go-librespot Websocket established Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetQueue Oct 26 20:58:29 volumio volumio[921]: info: CoreStateMachine::getQueue Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getQueue Oct 26 20:58:29 volumio volumio[921]: info: Listing playlists Oct 26 20:58:29 volumio volumio[921]: verbose: New Socket.io Connection to 192.168.101.4 from 192.168.101.3 UA: Mozilla/5.0 (Linux; Android 15; SM-S9010 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Total Clients: 29 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 20:58:29 volumio volumio[921]: info: Received Get System Info Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 20:58:29 volumio volumio[921]: info: Discovery: Getting this device information Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetQueue Oct 26 20:58:29 volumio volumio[921]: info: CoreStateMachine::getQueue Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getQueue Oct 26 20:58:29 volumio volumio[921]: info: Listing playlists Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 20:58:29 volumio volumio[921]: info: Received Get System Info Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 20:58:29 volumio volumio[921]: info: Discovery: Getting this device information Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 20:58:29 volumio volumio[921]: info: CoreCommandRouter::volumioGetState Oct 26 20:58:29 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Oct 26 20:58:29 volumio volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 20:58:29 volumio volumio[921]: Error: connect ETIMEDOUT 52.58.1.161:443 Oct 26 20:58:29 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 26 20:58:29 volumio volumio[921]: errno: -110, Oct 26 20:58:29 volumio volumio[921]: code: 'ETIMEDOUT', Oct 26 20:58:29 volumio volumio[921]: syscall: 'connect', Oct 26 20:58:29 volumio volumio[921]: address: '52.58.1.161', Oct 26 20:58:29 volumio volumio[921]: port: 443 Oct 26 20:58:29 volumio volumio[921]: } Oct 26 20:58:29 volumio volumio[921]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 20:58:29 volumio sudo[2169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-26 20:57 Oct 26 20:58:29 volumio sudo[2169]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"