-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2025-03-17 00:16:40 CST. -- Mar 17 00:15:00 volumio volumio[928]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: warn: Unable to locate the device HDMI Out a reboot may be required. Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: Invalid card number. Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 17 00:15:00 volumio volumio[928]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 17 00:15:00 volumio volumio[928]: info: Disabling external Volume Control Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:00 volumio volumio[928]: info: Enable softmixer device for audio device undefined Mar 17 00:15:00 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:15:00 volumio volumio[928]: info: Software Volume ALSA configuration written Mar 17 00:15:00 volumio volumio[928]: info: Preparing to generate the ALSA configuration file Mar 17 00:15:00 volumio volumio[928]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 17 00:15:00 volumio volumio[928]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Mar 17 00:15:00 volumio volumio[928]: info: Reading ALSA contributions from plugins. Mar 17 00:15:00 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:00 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:15:00 volumio volumio[928]: info: Getting Alsa Cards List without I2S DAC Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: Invalid card number. Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 17 00:15:00 volumio volumio[928]: info: Asound.conf file unchanged, so no further update is needed Mar 17 00:15:00 volumio volumio[928]: info: Output device has changed, restarting MPD Mar 17 00:15:00 volumio sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 17 00:15:00 volumio sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:15:00 volumio volumio[928]: info: Output device has changed, restarting Shairport Sync Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio sudo[1860]: pam_unix(sudo:session): session closed for user root Mar 17 00:15:00 volumio sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 17 00:15:00 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:15:00 volumio systemd[1]: Stopping Music Player Daemon... Mar 17 00:15:00 volumio systemd[1]: mpd.service: Succeeded. Mar 17 00:15:00 volumio systemd[1]: Stopped Music Player Daemon. Mar 17 00:15:00 volumio volumio[928]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 17 00:15:00 volumio volumio[928]: info: MPD Permissions set Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:00 volumio volumio[928]: info: Starting Shairport Sync Mar 17 00:15:00 volumio systemd[1]: Starting Music Player Daemon... Mar 17 00:15:00 volumio sudo[1874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 17 00:15:00 volumio sudo[1874]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:15:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 17 00:15:00 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 17 00:15:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 17 00:15:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 17 00:15:01 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:15:01 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:01 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:15:01 volumio volumio[928]: (node:928) 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: 4) Mar 17 00:15:01 volumio sudo[1874]: pam_unix(sudo:session): session closed for user root Mar 17 00:15:01 volumio volumio[928]: info: Shairport-Sync Started Mar 17 00:15:01 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:15:01 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:01 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:01 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:01 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:01 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Mar 17 00:15:01 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:01 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:01 volumio go-librespot[1879]: Librespot-go daemon starting... Mar 17 00:15:01 volumio go-librespot[1879]: time="2025-03-17T00:15:01+08:00" level=info msg="generated new device id: 09b271802e83ed125127c226c5169f6f1020ad9d" Mar 17 00:15:01 volumio go-librespot[1879]: time="2025-03-17T00:15:01+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:01 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:01 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:01 volumio mpd[1868]: Mar 17 00:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 17 00:15:01 volumio systemd[1]: Started Music Player Daemon. Mar 17 00:15:01 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root Mar 17 00:15:01 volumio volumio[928]: error: updateQueue error: null Mar 17 00:15:01 volumio go-librespot[1879]: time="2025-03-17T00:15:01+08:00" level=debug msg="obtained new client token: AAA69TLOfZVY4TGc2uXn4QRNWklnMJH4FRB5EMVQH3kcoHTIrryncyNr/qjqzl8ACXK1DhE7gMm4QdmbA1K0xDLGNloJMR3y/Y99dy17FiQr+5QY19xk8tF29MfonKPyB8pHeU1qy4m+/jtGdIOyCFfqVTkTyK3d7CQ3VrFZXjQHRH8muCUQL/R1ovzgywEG8AXOnxQdGV08NlmS5ThvFvvfc0tuzeLP6avWxCaz5SgO8nB7pMPFu3lC/VDLy5lOLQ==" Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::volumioGetBrowseSources Mar 17 00:15:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 17 00:15:03 volumio go-librespot[1879]: time="2025-03-17T00:15: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-gew1.spotify.com:80]" Mar 17 00:15:03 volumio go-librespot[1879]: time="2025-03-17T00:15:03+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:03 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:04 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:04 volumio go-librespot[1879]: time="2025-03-17T00:15:04+08:00" level=debug msg="new websocket client" Mar 17 00:15:04 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:15:04 volumio go-librespot[1879]: time="2025-03-17T00:15:04+08:00" level=debug msg="completed challenge" Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 17 00:15:04 volumio volumio[928]: info: CoreStateMachine::getcurrentVolume Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioRetrievevolume Mar 17 00:15:04 volumio go-librespot[1879]: time="2025-03-17T00:15:04+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" Mar 17 00:15:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:04 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:15:04 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:15:04 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:04 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:04 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:04 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:04 volumio volumio[928]: info: CoreStateMachine::updateTrackBlock Mar 17 00:15:04 volumio volumio[928]: info: CorePlayQueue::getTrackBlock Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioRetrievevolume Mar 17 00:15:04 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:15:04 volumio volumio[928]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 17 00:15:04 volumio volumio[928]: info: Completed starting MyVolumio Plugin Mar 17 00:15:04 volumio volumio[928]: info: BOOT COMPLETED Mar 17 00:15:04 volumio volumio[928]: [Metrics] CommandRouter: 106s 954.49ms Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumiosetStartupVolume Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::Close All Modals sent Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::Close All Modals sent Mar 17 00:15:04 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:04 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:04 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:04 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:04 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:04 volumio volumio[928]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 17 00:15:04 volumio volumio[928]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Mar 17 00:15:04 volumio volumio[928]: aplay: main:828: audio open error: No such device Mar 17 00:15:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 17 00:15:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:15:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 17 00:15:07 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:15:07 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:07 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:15:07 volumio volumio[928]: (node:928) 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: 5) Mar 17 00:15:07 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:15:07 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:07 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:07 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Mar 17 00:15:07 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:07 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:07 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:07 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:07 volumio go-librespot[1895]: Librespot-go daemon starting... Mar 17 00:15:07 volumio go-librespot[1895]: time="2025-03-17T00:15:07+08:00" level=info msg="generated new device id: 282eb62524132ae618e9de3214db84eac55e6128" Mar 17 00:15:07 volumio go-librespot[1895]: time="2025-03-17T00:15:07+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:08 volumio go-librespot[1895]: time="2025-03-17T00:15:08+08:00" level=debug msg="obtained new client token: AABcNX7p7Gsj35F55Hjj1N1IAaKR9PpjTjEVEm+FojSwGNgnPcde8ENZk/4kz4gLLmb/uvLuJjI+6aVO6bRWTebfCk0zjaBS8YbBWoqPcIUuQfkCmCBrEhIYuSYtbAw4mzYSpnPN+rrO7Fh9V92hqnFGjdaYI9LU7VFIZ8JbgSq4XO5uw7Kb8QGYYJc6ridaq/QHHvW7l1BXBZrNtTYIwENXU3qNeUsBOM3dfmmX64k254pjY9Jvkid58KG/0q4=" Mar 17 00:15:09 volumio go-librespot[1895]: time="2025-03-17T00:15:09+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]" Mar 17 00:15:09 volumio go-librespot[1895]: time="2025-03-17T00:15:09+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:10 volumio go-librespot[1895]: time="2025-03-17T00:15:10+08:00" level=debug msg="completed challenge" Mar 17 00:15:10 volumio go-librespot[1895]: time="2025-03-17T00:15:10+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" Mar 17 00:15:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:10 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:10 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:11 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:13 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Mar 17 00:15:13 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:13 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:13 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:13 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:13 volumio go-librespot[1915]: Librespot-go daemon starting... Mar 17 00:15:13 volumio go-librespot[1915]: time="2025-03-17T00:15:13+08:00" level=info msg="generated new device id: aef51eccc5ad1be41055b609c8814abdae6253f4" Mar 17 00:15:13 volumio go-librespot[1915]: time="2025-03-17T00:15:13+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:14 volumio go-librespot[1915]: time="2025-03-17T00:15:14+08:00" level=debug msg="obtained new client token: AADkRYXgU2FR32zpBg0HcU8dIGZxvM8esZkYZc7EM/6f+K1qofmmXCfnoTzW9THSbyPtfKjOZ+2zwiimHPrfGEjIyQTTrA1b3UqVSinJ+J8+TcuQlsPRHyGNu1sidYJesGJlYaNx3FGF47DlRlvES6g77OHpFHDvE9IkgpUs9QDEys7hS7QRWPG9mh28A6vZSLSSzCqnJFb2A+QlPrS7yQgmdP5ZydioRLmBv7JVTCcn7xqE3c4yWDUj/gRfbbA=" Mar 17 00:15:15 volumio go-librespot[1915]: time="2025-03-17T00:15:15+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]" Mar 17 00:15:15 volumio go-librespot[1915]: time="2025-03-17T00:15:15+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:15 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 17 00:15:15 volumio go-librespot[1915]: time="2025-03-17T00:15:15+08:00" level=debug msg="completed challenge" Mar 17 00:15:15 volumio go-librespot[1915]: time="2025-03-17T00:15: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" Mar 17 00:15:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:16 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:16 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:17 volumio volumio[1062]: ...................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Mar 17 00:15:17 volumio volumio[1062]: e is 65537 (0x010001) Mar 17 00:15:17 volumio volumio[1062]: writing RSA key Mar 17 00:15:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8. Mar 17 00:15:18 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:18 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:18 volumio go-librespot[1995]: Librespot-go daemon starting... Mar 17 00:15:19 volumio go-librespot[1995]: time="2025-03-17T00:15:19+08:00" level=info msg="generated new device id: 7889cbc8f44cfa8a9c675f6ad83f2af7c278911b" Mar 17 00:15:19 volumio go-librespot[1995]: time="2025-03-17T00:15:19+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:19 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:19 volumio go-librespot[1995]: time="2025-03-17T00:15:19+08:00" level=debug msg="new websocket client" Mar 17 00:15:19 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:15:19 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:19 volumio go-librespot[1995]: time="2025-03-17T00:15:19+08:00" level=debug msg="obtained new client token: AAAYAkHbE5ECmFLhwV9Jou/ZR+jG6pmU24Zl4B+kj8AkuY7tommr7kH9i5zHibqu/yiHElm7wjp9IxxKmTflXLtdJ4wwxxlm3KNemDbczVUyVutdBx3dFfMk+wyoWZ4gPL36vgmrGxzR8V9j1OutS6oKzQzQrQYj0jaihYzTKM+wRLRxEb0BOU0hkImhsW8SiuISuSrIGXNuaZ84nuqHRPqZXWxxHqajWmbxd1BRn7aUJ7O+62KOMU0geWxoIkmwyg==" Mar 17 00:15:19 volumio volumio[928]: info: CoreCommandRouter::volumioRandom Mar 17 00:15:19 volumio volumio[928]: info: CoreCommandRouter::writePlayerControls Mar 17 00:15:19 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:19 volumio volumio[928]: info: CoreStateMachine::setRepeat true single false Mar 17 00:15:19 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:19 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:19 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 00:15:19 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:20 volumio go-librespot[1995]: time="2025-03-17T00:15:20+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]" Mar 17 00:15:20 volumio go-librespot[1995]: time="2025-03-17T00:15:20+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:21 volumio go-librespot[1995]: time="2025-03-17T00:15:21+08:00" level=debug msg="completed challenge" Mar 17 00:15:21 volumio go-librespot[1995]: time="2025-03-17T00:15:21+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" Mar 17 00:15:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:21 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:15:22 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:15:22 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:22 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:15:22 volumio volumio[928]: (node:928) 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: 6) Mar 17 00:15:22 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:15:22 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:22 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:24 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:24 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:24 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Mar 17 00:15:24 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:24 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:24 volumio go-librespot[2014]: Librespot-go daemon starting... Mar 17 00:15:24 volumio go-librespot[2014]: time="2025-03-17T00:15:24+08:00" level=info msg="generated new device id: 157718bed8a6706c53d0cecc4cc5658274fc7883" Mar 17 00:15:24 volumio go-librespot[2014]: time="2025-03-17T00:15:24+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:25 volumio go-librespot[2014]: time="2025-03-17T00:15:25+08:00" level=debug msg="obtained new client token: AAA84JLaN9e5ff6o/zeWSga4CqjO2h9mncGXT4toUYYx3tKPMWqoj8Dukr9D/l590WMMgib2evg58KW1sccMwiJWegCC7NwHL1kVuHOUxbIH3w5vlibGLmq0A+7PyhJ4oaFomAS55ufcgSCaTXWiuEDnfgfpOY8lu3kjan+6dLV/yZI65CNLhsK0GdhkFFV70NYC5h8u5UN5+QtEMcNNoQcuWGlG5kugbtKCOMM7dg1X5DNxIQ/0vlrKRkOlc0g=" Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: info: Retrieving Cloud Streaming UI Mar 17 00:15:25 volumio volumio[928]: info: Getting Tidal Cloud Configuration Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: info: Getting Qobuz Cloud Configuration Mar 17 00:15:25 volumio volumio[928]: info: Asking plugin for UI Config Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: info: Getting Spotify Cloud Configuration Mar 17 00:15:25 volumio volumio[928]: info: Asking plugin for UI Config Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: info: Saving Spotify Acccount Mar 17 00:15:25 volumio volumio[928]: info: Got Tidal Cloud Configuration Mar 17 00:15:25 volumio volumio[928]: info: Got it Mar 17 00:15:25 volumio volumio[928]: info: Got it Mar 17 00:15:25 volumio volumio[928]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:25 volumio volumio[928]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::volumioGetBrowseSources Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::volumioGetBrowseSources Mar 17 00:15:25 volumio volumio[928]: info: CoreCommandRouter::volumioGetBrowseSources Mar 17 00:15:25 volumio go-librespot[2014]: time="2025-03-17T00:15:25+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]" Mar 17 00:15:25 volumio go-librespot[2014]: time="2025-03-17T00:15:25+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:26 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 17 00:15:26 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 17 00:15:26 volumio go-librespot[2014]: time="2025-03-17T00:15:26+08:00" level=debug msg="completed challenge" Mar 17 00:15:27 volumio go-librespot[2014]: time="2025-03-17T00:15:27+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" Mar 17 00:15:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:27 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:27 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:27 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 17 00:15:28 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand update Mar 17 00:15:28 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status Mar 17 00:15:28 volumio volumio[928]: info: Mar 17 00:15:28 volumio volumio[928]: ---------------------------- MPD announces state update: update Mar 17 00:15:28 volumio volumio[928]: info: sendMpdCommand update took 7 milliseconds Mar 17 00:15:28 volumio volumio[928]: info: ControllerMpd::getState Mar 17 00:15:28 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status Mar 17 00:15:28 volumio volumio[928]: info: sendMpdCommand status took 16 milliseconds Mar 17 00:15:28 volumio volumio[928]: verbose: ControllerMpd::parseState Mar 17 00:15:28 volumio volumio[928]: info: Command Router : Notfying DB Updatetrue Mar 17 00:15:28 volumio volumio[928]: info: sendMpdCommand status took 184 milliseconds Mar 17 00:15:28 volumio volumio[928]: verbose: ControllerMpd::parseState Mar 17 00:15:28 volumio volumio[928]: info: ControllerMpd::pushState Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::servicePushState Mar 17 00:15:28 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:28 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:28 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:28 volumio volumio[928]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 17 00:15:28 volumio volumio[928]: verbose: CURRENT POSITION 0 Mar 17 00:15:28 volumio volumio[928]: info: CoreStateMachine::syncState stateService stop Mar 17 00:15:28 volumio volumio[928]: info: CoreStateMachine::syncState currentStatus stop Mar 17 00:15:28 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:28 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:28 volumio volumio[928]: info: No code Mar 17 00:15:28 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:28 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:28 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:28 volumio volumio[928]: info: ------------------------------ 240ms Mar 17 00:15:30 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Mar 17 00:15:30 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:30 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:30 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:30 volumio volumio[928]: info: MPD Database updated - AlbumList cache refreshed Mar 17 00:15:30 volumio volumio[928]: info: Mar 17 00:15:30 volumio volumio[928]: ---------------------------- MPD announces state update: database Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status Mar 17 00:15:30 volumio volumio[928]: info: Mar 17 00:15:30 volumio volumio[928]: ---------------------------- MPD announces state update: update Mar 17 00:15:30 volumio volumio[928]: info: ControllerMpd::getState Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status Mar 17 00:15:30 volumio volumio[928]: info: ControllerMpd::getState Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status Mar 17 00:15:30 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:30 volumio volumio[928]: info: sendMpdCommand status took 14 milliseconds Mar 17 00:15:30 volumio volumio[928]: info: sendMpdCommand status took 13 milliseconds Mar 17 00:15:30 volumio volumio[928]: info: sendMpdCommand status took 14 milliseconds Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::parseState Mar 17 00:15:30 volumio go-librespot[2025]: Librespot-go daemon starting... Mar 17 00:15:30 volumio go-librespot[2025]: time="2025-03-17T00:15:30+08:00" level=info msg="generated new device id: 0dbf97472796e4eb22bc842abcba2d37e67d382d" Mar 17 00:15:30 volumio go-librespot[2025]: time="2025-03-17T00:15:30+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:30 volumio volumio[928]: info: Command Router : Notfying DB Updatefalse Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::Close All Modals sent Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::parseState Mar 17 00:15:30 volumio volumio[928]: verbose: ControllerMpd::parseState Mar 17 00:15:30 volumio volumio[928]: info: ControllerMpd::pushState Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::servicePushState Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 17 00:15:30 volumio volumio[928]: verbose: CURRENT POSITION 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::syncState stateService stop Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::syncState currentStatus stop Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: No code Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: ControllerMpd::pushState Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::servicePushState Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 17 00:15:30 volumio volumio[928]: verbose: CURRENT POSITION 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::syncState stateService stop Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::syncState currentStatus stop Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: No code Mar 17 00:15:30 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:30 volumio volumio[928]: info: ------------------------------ 165ms Mar 17 00:15:30 volumio volumio[928]: info: ------------------------------ 166ms Mar 17 00:15:30 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 17 00:15:30 volumio go-librespot[2025]: time="2025-03-17T00:15:30+08:00" level=debug msg="obtained new client token: AAAoRh6STwrMI+gETOcn5hRsN/3NiPVWbIk19W9DX5tWX/T1tWFOXkUsherCf6G9j4/uXhqsP+R23mbOwxXVvjJ60pKSsL6M/ujD9ROo1BLtVKF4K1QGXyTm8QLS36LQvHj25cLS5Ge3MeBZeLalZgWIAgYkl2kepbPL+K0LKK55iuAxd08NuQxXxtGowz1nxc3qM8CZuNvgw2UxR7rusg6E/OroZtiSlqVVJO1SmbeEhZZcMmxhs3zbg0YavVcX7A==" Mar 17 00:15:31 volumio go-librespot[2025]: time="2025-03-17T00:15:31+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]" Mar 17 00:15:31 volumio go-librespot[2025]: time="2025-03-17T00:15:31+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:32 volumio go-librespot[2025]: time="2025-03-17T00:15:32+08:00" level=debug msg="completed challenge" Mar 17 00:15:32 volumio go-librespot[2025]: time="2025-03-17T00:15:32+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" Mar 17 00:15:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:33 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:33 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:33 volumio volumio[928]: info: Disabling MyMusic plugin upnp Mar 17 00:15:33 volumio sudo[2036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 17 00:15:33 volumio sudo[2036]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:15:33 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 17 00:15:33 volumio volumio[928]: error: Upnp client error: Error: This socket has been ended by the other party Mar 17 00:15:34 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 17 00:15:35 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Mar 17 00:15:35 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:35 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:35 volumio go-librespot[2038]: Librespot-go daemon starting... Mar 17 00:15:35 volumio go-librespot[2038]: time="2025-03-17T00:15:35+08:00" level=info msg="generated new device id: 29886319be9acd8bd938e5bf32da23d9be42456f" Mar 17 00:15:35 volumio go-librespot[2038]: time="2025-03-17T00:15:35+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:35 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:36 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:36 volumio go-librespot[2038]: time="2025-03-17T00:15:36+08:00" level=debug msg="new websocket client" Mar 17 00:15:36 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:15:36 volumio volumio[928]: info: CoreCommandRouter::volumioPlay Mar 17 00:15:36 volumio volumio[928]: info: CoreStateMachine::play index undefined Mar 17 00:15:36 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:36 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:37 volumio volumio[928]: info: CoreCommandRouter::volumioNext Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::next Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::stop Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::play index undefined Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:37 volumio volumio[928]: info: CorePlayQueue::getTrack 1 Mar 17 00:15:37 volumio volumio[928]: info: CoreCommandRouter::volumioNext Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::next Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::stop Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::play index undefined Mar 17 00:15:37 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:37 volumio volumio[928]: info: CorePlayQueue::getTrack 1 Mar 17 00:15:37 volumio go-librespot[2038]: time="2025-03-17T00:15:37+08:00" level=debug msg="obtained new client token: AABN+7oqChsmaIKmzYmsDM+VJpYMmKLKN/88oEsIGxyvtFGWQKmsa+4KMj2Q0qcSZE7qmaI0rtzOfnuwpvWC9M986wHjWVKGDfilzdXyVjFERePEDe9kQlxXsSIi3DDh9p/vZl5a3JwXfB92V6lychcWbWNGDXfOvWeqDEggWuzlKG5Cty0tiH0kL6sy8c7ydCtPaiZlG+Y/cDyQCFDlM/DEWP7jopMl8TgFLCI04FE5fZ6y9IvQoKIDb/HUCsI=" Mar 17 00:15:38 volumio volumio[928]: info: CoreCommandRouter::volumioNext Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::next Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::stop Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::play index undefined Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:38 volumio volumio[928]: info: CorePlayQueue::getTrack 1 Mar 17 00:15:38 volumio volumio[928]: info: CoreCommandRouter::volumioNext Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::next Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::stop Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::play index undefined Mar 17 00:15:38 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:15:38 volumio volumio[928]: info: CorePlayQueue::getTrack 1 Mar 17 00:15:39 volumio go-librespot[2038]: time="2025-03-17T00:15: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Mar 17 00:15:39 volumio go-librespot[2038]: time="2025-03-17T00:15:39+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:39 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:15:39 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:15:39 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:39 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:39 volumio go-librespot[2038]: time="2025-03-17T00:15:39+08:00" level=debug msg="completed challenge" Mar 17 00:15:39 volumio go-librespot[2038]: time="2025-03-17T00:15:39+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" Mar 17 00:15:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:39 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: socket hang up Mar 17 00:15:39 volumio volumio[928]: at connResetException (internal/errors.js:607:14) Mar 17 00:15:39 volumio volumio[928]: at Socket.socketOnEnd (_http_client.js:493:23) Mar 17 00:15:39 volumio volumio[928]: at Socket.emit (events.js:327:22) Mar 17 00:15:39 volumio volumio[928]: at endReadableNT (internal/streams/readable.js:1327:12) Mar 17 00:15:39 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 17 00:15:39 volumio volumio[928]: (node:928) 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: 7) Mar 17 00:15:39 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:15:41 volumio volumio[928]: info: VolumeController::SetAlsaVolume54 Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:41 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:41 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:41 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: SPOTIFY VOLUME undefined Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: VOLUMIO VOLUME 54 Mar 17 00:15:41 volumio volumio[928]: info: Aligning Spotify Volume to Volumio Volume Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:41 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:41 volumio volumio[928]: info: Setting Spotify Volume from Volumio: 54 Mar 17 00:15:41 volumio volumio[928]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:15:41 volumio volumio[928]: info: VolumeController::SetAlsaVolume58 Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:41 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:41 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:15:41 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 00:15:41 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: SPOTIFY VOLUME 54 Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: VOLUMIO VOLUME 58 Mar 17 00:15:41 volumio volumio[928]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 17 00:15:41 volumio volumio[928]: info: Setting Spotify Volume from Volumio: 58 Mar 17 00:15:41 volumio volumio[928]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:15:42 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:42 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:42 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Mar 17 00:15:42 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:43 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:43 volumio go-librespot[2049]: Librespot-go daemon starting... Mar 17 00:15:43 volumio go-librespot[2049]: time="2025-03-17T00:15:43+08:00" level=info msg="generated new device id: 2d364c7e93526fc92789c33752ce2611af5d2564" Mar 17 00:15:43 volumio go-librespot[2049]: time="2025-03-17T00:15:43+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:43 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:43 volumio volumio[928]: SPOTIFY: SETTING SPOTIFY VOLUME 58 Mar 17 00:15:43 volumio volumio[928]: info: Sending Spotify command with payload to local API: /player/volume Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:15:43 volumio volumio[928]: info: Getting Alsa Cards List without I2S DAC Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:15:43 volumio volumio[928]: Invalid card number. Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 17 00:15:43 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 17 00:15:43 volumio go-librespot[2049]: time="2025-03-17T00:15:43+08:00" level=debug msg="obtained new client token: AAAG9QE2YEAS1T47ZamgTsHQ6lUdXpFnsJBY8/valUb9m+sELBRJ6FyksP0vwzvSduDE/tA2crMorxVuKEOSQsFtbYqtrcAsp22xnBcB3znOiq6BATmI5rBIbdLS+ibrjPJrFVTAKMJeyEFUKtesIe6JibMDhAgMIKJ/DrrbIp7YBECFsOzVry9WVKnRU1WHdePuq1FYbu6qBbXDQtrGVx+IdkUmQ5akAk+HTfF21J2/koaja1Zw7pQYaOrn2RMILA==" Mar 17 00:15:44 volumio go-librespot[2049]: time="2025-03-17T00:15:44+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]" Mar 17 00:15:44 volumio go-librespot[2049]: time="2025-03-17T00:15:44+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:44 volumio go-librespot[2049]: time="2025-03-17T00:15:44+08:00" level=debug msg="completed challenge" Mar 17 00:15:44 volumio go-librespot[2049]: time="2025-03-17T00:15:44+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" Mar 17 00:15:44 volumio volumio[928]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Mar 17 00:15:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:45 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:45 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:48 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Mar 17 00:15:48 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:48 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:48 volumio go-librespot[2065]: Librespot-go daemon starting... Mar 17 00:15:48 volumio go-librespot[2065]: time="2025-03-17T00:15:48+08:00" level=info msg="generated new device id: 2fe00cab646aad524a49378aba8278bc3f8e93fb" Mar 17 00:15:48 volumio go-librespot[2065]: time="2025-03-17T00:15:48+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:48 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:48 volumio go-librespot[2065]: time="2025-03-17T00:15:48+08:00" level=debug msg="new websocket client" Mar 17 00:15:48 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:15:48 volumio go-librespot[2065]: time="2025-03-17T00:15:48+08:00" level=debug msg="obtained new client token: AAByVNYUKmG9g/TADhKnpBiGjM4jUOQbG2h68EYMUsNO8nW3bcN3yUozGJk432GmHBODq0R6CD07VqIqtKZcG61j74BD6bbJi3lpviW5veu2RaNmAtJEgI9mOYohQtJTN+0MWOfpaYaZev9zz8e2kE7ccuInOWQ+HsWs4Y3ajtEzn+KXrZ8TWTQNR//O9APLJg0SBYYOxdL44ZyB/oG7kRc2OzcdG9IFbkEEr2+K7hoTPQ2SuecE4xXpu+kZeg273w==" Mar 17 00:15:49 volumio go-librespot[2065]: time="2025-03-17T00:15:49+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]" Mar 17 00:15:49 volumio go-librespot[2065]: time="2025-03-17T00:15:49+08:00" level=debug msg="completed keyexchange" Mar 17 00:15:50 volumio go-librespot[2065]: time="2025-03-17T00:15:50+08:00" level=debug msg="completed challenge" Mar 17 00:15:50 volumio go-librespot[2065]: time="2025-03-17T00:15:50+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" Mar 17 00:15:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:50 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:15:51 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:51 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:15:51 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:51 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:15:51 volumio volumio[928]: (node:928) 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: 8) Mar 17 00:15:51 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:15:51 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:15:51 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:15:51 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:15:53 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:53 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:53 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Mar 17 00:15:53 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:53 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:53 volumio go-librespot[2114]: Librespot-go daemon starting... Mar 17 00:15:53 volumio go-librespot[2114]: time="2025-03-17T00:15:53+08:00" level=info msg="generated new device id: 038f7985cd9488c3041822f3869cbcb9d1f59d73" Mar 17 00:15:53 volumio go-librespot[2114]: time="2025-03-17T00:15:53+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:53 volumio go-librespot[2114]: time="2025-03-17T00:15:53+08:00" level=debug msg="obtained new client token: AAA9Nei840EQIh/qZtsybdISl5rOmaIyNYm9PTxA3Eu/uPdzUMVx8blwzhehvwVUoTSKcE85SgjWebbfezrVecrUl43P8OYvXy0R7O3XUHOKhioJqraHMevRviofaPNCqpf1RAsK6Fk05XvvxYVwWX4jXWqXkWEJmJBbJodG43LUNjDMw1FlzxZVuReW/HRj1MXCB8FL1NIfJwfrQtRJ3uQ9/EhRNtMmR9VKj79GL///ilDxRwgMJ6v+CGpgXN2qMA==" Mar 17 00:15:54 volumio go-librespot[2114]: time="2025-03-17T00:15:54+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]" Mar 17 00:15:54 volumio go-librespot[2114]: time="2025-03-17T00:15:54+08:00" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 104.199.241.202:4070: connect: connection refused" Mar 17 00:15:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:15:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:15:56 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:56 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:15:57 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:15:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Mar 17 00:15:57 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:15:57 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:15:57 volumio go-librespot[2122]: Librespot-go daemon starting... Mar 17 00:15:57 volumio go-librespot[2122]: time="2025-03-17T00:15:57+08:00" level=info msg="generated new device id: 530c29b8ceb8286e13e500fb1748cba973fd3bc6" Mar 17 00:15:57 volumio go-librespot[2122]: time="2025-03-17T00:15:57+08:00" level=debug msg="stored credentials not found" Mar 17 00:15:58 volumio go-librespot[2122]: time="2025-03-17T00:15:58+08:00" level=debug msg="obtained new client token: AADw9VZnf4G+B2Q7Ym7BX0ummiEk190XLFcrH6eoBEDNvdnTip/cDrxd+A/TvpjllJ0I/RvJXfNpjTflfmMFpHVpGYsrr3JJTQMPYCNvmiXQ5l4ByMdq/NnujzStF+6sRWwuKaJ/45/uu64BgRwC1WtIP/Uwsep+mSKvehDXTAwFHaPp9M/wOEhaCpxicpSa8HUHYgpvRpZMShnOe39Wexh62Aj3SGdG5bGZC/QJ6wyljTd9QnPpGikMw6sCE+ASDw==" Mar 17 00:15:58 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:15:59 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:15:59 volumio go-librespot[2122]: time="2025-03-17T00:15:59+08:00" level=debug msg="new websocket client" Mar 17 00:15:59 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:16:00 volumio go-librespot[2122]: time="2025-03-17T00:16:00+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]" Mar 17 00:16:00 volumio go-librespot[2122]: time="2025-03-17T00:16:00+08:00" level=debug msg="completed keyexchange" Mar 17 00:16:01 volumio go-librespot[2122]: time="2025-03-17T00:16:01+08:00" level=debug msg="completed challenge" Mar 17 00:16:01 volumio go-librespot[2122]: time="2025-03-17T00:16:01+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" Mar 17 00:16:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:16:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:16:01 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:16:02 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:16:02 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:02 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:16:02 volumio volumio[928]: (node:928) 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: 9) Mar 17 00:16:02 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:02 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:02 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:02 volumio volumio[928]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:02 volumio volumio[928]: warn: Unable to locate the device HDMI Out a reboot may be required. Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:02 volumio volumio[928]: Invalid card number. Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 17 00:16:02 volumio volumio[928]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 17 00:16:02 volumio volumio[928]: info: Disabling external Volume Control Mar 17 00:16:02 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:16:02 volumio volumio[928]: info: Enable softmixer device for audio device undefined Mar 17 00:16:02 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:16:03 volumio volumio[928]: info: Software Volume ALSA configuration written Mar 17 00:16:03 volumio volumio[928]: info: Preparing to generate the ALSA configuration file Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:16:03 volumio volumio[928]: info: Getting Alsa Cards List without I2S DAC Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:03 volumio volumio[928]: Invalid card number. Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 17 00:16:03 volumio volumio[928]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 17 00:16:03 volumio volumio[928]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Mar 17 00:16:03 volumio volumio[928]: info: Reading ALSA contributions from plugins. Mar 17 00:16:03 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:03 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:03 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:16:03 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:16:03 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:03 volumio volumio[928]: info: Asound.conf file unchanged, so no further update is needed Mar 17 00:16:03 volumio volumio[928]: info: Output device has changed, restarting MPD Mar 17 00:16:03 volumio sudo[2150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 17 00:16:03 volumio sudo[2150]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:16:03 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Mar 17 00:16:03 volumio volumio[928]: info: Output device has changed, restarting Shairport Sync Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:03 volumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 17 00:16:03 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:16:03 volumio systemd[1]: Stopping Music Player Daemon... Mar 17 00:16:03 volumio systemd[1]: mpd.service: Succeeded. Mar 17 00:16:03 volumio systemd[1]: Stopped Music Player Daemon. Mar 17 00:16:03 volumio volumio[928]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 17 00:16:03 volumio volumio[928]: info: MPD Permissions set Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio systemd[1]: Starting Music Player Daemon... Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: Starting Shairport Sync Mar 17 00:16:03 volumio sudo[2165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 17 00:16:03 volumio sudo[2165]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:16:03 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 17 00:16:03 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 17 00:16:03 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 17 00:16:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 17 00:16:03 volumio sudo[2165]: pam_unix(sudo:session): session closed for user root Mar 17 00:16:03 volumio volumio[928]: info: Shairport-Sync Started Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 17 00:16:03 volumio mpd[2159]: Mar 17 00:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 17 00:16:03 volumio systemd[1]: Started Music Player Daemon. Mar 17 00:16:03 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Mar 17 00:16:03 volumio volumio[928]: error: updateQueue error: null Mar 17 00:16:04 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:04 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:04 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:16:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Mar 17 00:16:04 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:16:04 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:16:04 volumio go-librespot[2172]: Librespot-go daemon starting... Mar 17 00:16:04 volumio go-librespot[2172]: time="2025-03-17T00:16:04+08:00" level=info msg="generated new device id: 5d1620bcf14dbee9ce0696eee0a2fd66fea28dd8" Mar 17 00:16:04 volumio go-librespot[2172]: time="2025-03-17T00:16:04+08:00" level=debug msg="stored credentials not found" Mar 17 00:16:04 volumio sudo[2180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 17 00:16:04 volumio sudo[2180]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:16:04 volumio sudo[2180]: pam_unix(sudo:session): session closed for user root Mar 17 00:16:04 volumio sudo[2184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 17 00:16:04 volumio sudo[2184]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 17 00:16:05 volumio sudo[2184]: pam_unix(sudo:session): session closed for user root Mar 17 00:16:05 volumio volumio[928]: verbose: New Socket.io Connection to 192.168.1.61 from 192.168.1.6 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 23013RK75C Build/AQ3A.240912.001) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/122.0.6261.119 Mobile Safari/537.36 XiaoMi/MiuiBrowser/19.2.40312 Total Clients: 8 Mar 17 00:16:05 volumio go-librespot[2172]: time="2025-03-17T00:16:05+08:00" level=debug msg="obtained new client token: AAB9lc4T1WYlVK0WAisEMYc/2vtjJmXNYu/9L4oQX5qcS8U1viuIAyibjZ/Ec+STB7iYOKit81dtZLWT2fqnci6/TLzzSaiOwqIedMcHd5eI8rBiDyb89kUquCzaOyqWtaicHIesIonfAI/LeWmtkA15qWz3ysMGsya6FA+sq0D5hbQIgpx0UIwcxi1dbogXrfW5AagdOvOYO4Sw8szqUpzCRwPzzXd1yhBl0vwTqr8d8MqqBG1daW095qRX2TU=" Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::volumioGetVisibleSources Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:05 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 17 00:16:05 volumio volumio[928]: info: Getting Alsa Cards List without I2S DAC Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 17 00:16:05 volumio volumio[928]: Invalid card number. Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 17 00:16:05 volumio volumio[928]: info: Received Get System Info Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 17 00:16:05 volumio volumio[928]: info: Discovery: Getting this device information Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:05 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:05 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:05 volumio volumio[928]: info: Listing playlists Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 17 00:16:05 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 17 00:16:06 volumio go-librespot[2172]: time="2025-03-17T00:16:06+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]" Mar 17 00:16:06 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:16:06 volumio go-librespot[2172]: time="2025-03-17T00:16:06+08:00" level=debug msg="completed keyexchange" Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 17 00:16:06 volumio volumio[928]: info: Received Get System Info Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 17 00:16:06 volumio volumio[928]: info: Discovery: Getting this device information Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:06 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 17 00:16:06 volumio volumio[928]: info: CoreStateMachine::getcurrentVolume Mar 17 00:16:06 volumio volumio[928]: info: CoreCommandRouter::volumioRetrievevolume Mar 17 00:16:06 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:16:07 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:16:07 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:07 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:07 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:16:07 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:07 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:16:07 volumio volumio[928]: info: CoreStateMachine::updateTrackBlock Mar 17 00:16:07 volumio volumio[928]: info: CorePlayQueue::getTrackBlock Mar 17 00:16:07 volumio volumio[928]: info: CoreCommandRouter::volumioRetrievevolume Mar 17 00:16:07 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:07 volumio volumio[928]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 17 00:16:07 volumio volumio[928]: info: VolumeController:: Volume=undefined Mute =false Mar 17 00:16:07 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:07 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:07 volumio volumio[928]: info: CoreStateMachine::pushState Mar 17 00:16:07 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:07 volumio volumio[928]: info: CoreCommandRouter::volumioPushState Mar 17 00:16:07 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:07 volumio go-librespot[2172]: time="2025-03-17T00:16:07+08:00" level=debug msg="completed challenge" Mar 17 00:16:07 volumio go-librespot[2172]: time="2025-03-17T00:16:07+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" Mar 17 00:16:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:16:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:16:07 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:07 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:10 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:10 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:16:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Mar 17 00:16:10 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:16:10 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:16:10 volumio go-librespot[2204]: Librespot-go daemon starting... Mar 17 00:16:10 volumio go-librespot[2204]: time="2025-03-17T00:16:10+08:00" level=info msg="generated new device id: 8c7e3a66eb3cb475c230ec161d433a22c7939a17" Mar 17 00:16:10 volumio go-librespot[2204]: time="2025-03-17T00:16:10+08:00" level=debug msg="stored credentials not found" Mar 17 00:16:11 volumio go-librespot[2204]: time="2025-03-17T00:16:11+08:00" level=debug msg="obtained new client token: AAAX/8Dkpf+auXLwNW331VUR83hhK/fIv4J8tFlCPbn0i8vS6zEi0vTy73ibLJ5Gn7xDg/iueAhqLOt3jt/gd0ldxTc4+34/lL+EwDKFwiUzUKe52uwFT+Hw5iJddesBlhw3Fpu6IvE4gKrBDeuP1xFvwFvGQ3vuLbFuFkg+qNY3kt9H2grYk/IGdtoLxT5KeIeEGvn5rGrsxLuRQ9OnANoZ31aZtsMoXr1mbmEQumko9RcPj9ETMYVfegx39vU=" Mar 17 00:16:11 volumio go-librespot[2204]: time="2025-03-17T00:16: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Mar 17 00:16:11 volumio go-librespot[2204]: time="2025-03-17T00:16:11+08:00" level=debug msg="completed keyexchange" Mar 17 00:16:12 volumio go-librespot[2204]: time="2025-03-17T00:16:12+08:00" level=debug msg="completed challenge" Mar 17 00:16:12 volumio go-librespot[2204]: time="2025-03-17T00:16:12+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" Mar 17 00:16:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:16:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:16:13 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:13 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:13 volumio volumio[928]: info: CoreCommandRouter::volumioGetQueue Mar 17 00:16:13 volumio volumio[928]: info: CoreStateMachine::getQueue Mar 17 00:16:13 volumio volumio[928]: info: CorePlayQueue::getQueue Mar 17 00:16:13 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:13 volumio volumio[928]: info: CURURI: genres:// Mar 17 00:16:13 volumio volumio[928]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 17 00:16:13 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:14 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:16:15 volumio volumio[928]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Mar 17 00:16:15 volumio volumio[928]: LoungeScreenDisconnected { Mar 17 00:16:15 volumio volumio[928]: AID: null, Mar 17 00:16:15 volumio volumio[928]: name: 'loungeScreenDisconnected', Mar 17 00:16:15 volumio volumio[928]: payload: {} Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: IncompleteAPIDataError: Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Mar 17 00:16:15 volumio volumio[928]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Mar 17 00:16:15 volumio volumio[928]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:39:18) Mar 17 00:16:15 volumio volumio[928]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:339:67 Mar 17 00:16:15 volumio volumio[928]: at new Promise () Mar 17 00:16:15 volumio volumio[928]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:338:16) Mar 17 00:16:15 volumio volumio[928]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:236:28) Mar 17 00:16:15 volumio volumio[928]: at Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:207:26) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: at async Promise.all (index 1) Mar 17 00:16:15 volumio volumio[928]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:110:13) Mar 17 00:16:15 volumio volumio[928]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Mar 17 00:16:15 volumio volumio[928]: error: [yt-cast-receiver] Failed to start receiver: Mar 17 00:16:15 volumio volumio[928]: (AppError) Failed to start YouTubeApp Mar 17 00:16:15 volumio volumio[928]: --->(SessionError) (YouTube Music) Failed to establish session Mar 17 00:16:15 volumio volumio[928]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id Mar 17 00:16:15 volumio volumio[928]: Error info: { Mar 17 00:16:15 volumio volumio[928]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id' Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: --------->(FetchError) request to https://www.youtube.com/api/lounge/pairing/generate_screen_id failed, reason: connect ETIMEDOUT 31.13.94.49:443 Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: AppError: Failed to start YouTubeApp Mar 17 00:16:15 volumio volumio[928]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:125:19) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Mar 17 00:16:15 volumio volumio[928]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Mar 17 00:16:15 volumio volumio[928]: LoungeScreenDisconnected { Mar 17 00:16:15 volumio volumio[928]: AID: null, Mar 17 00:16:15 volumio volumio[928]: name: 'loungeScreenDisconnected', Mar 17 00:16:15 volumio volumio[928]: payload: {} Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: IncompleteAPIDataError: Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Mar 17 00:16:15 volumio volumio[928]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Mar 17 00:16:15 volumio volumio[928]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:39:18) Mar 17 00:16:15 volumio volumio[928]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:339:67 Mar 17 00:16:15 volumio volumio[928]: at new Promise () Mar 17 00:16:15 volumio volumio[928]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:338:16) Mar 17 00:16:15 volumio volumio[928]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:236:28) Mar 17 00:16:15 volumio volumio[928]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:118:35 Mar 17 00:16:15 volumio volumio[928]: at Array.forEach () Mar 17 00:16:15 volumio volumio[928]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:114:24) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Mar 17 00:16:15 volumio volumio[928]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Mar 17 00:16:15 volumio volumio[928]: LoungeScreenDisconnected { Mar 17 00:16:15 volumio volumio[928]: AID: null, Mar 17 00:16:15 volumio volumio[928]: name: 'loungeScreenDisconnected', Mar 17 00:16:15 volumio volumio[928]: payload: {} Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: IncompleteAPIDataError: Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Mar 17 00:16:15 volumio volumio[928]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Mar 17 00:16:15 volumio volumio[928]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Mar 17 00:16:15 volumio volumio[928]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: error: [ytcr] Failed to start plugin: Mar 17 00:16:15 volumio volumio[928]: (AppError) Failed to start YouTubeApp Mar 17 00:16:15 volumio volumio[928]: --->(SessionError) (YouTube Music) Failed to establish session Mar 17 00:16:15 volumio volumio[928]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id Mar 17 00:16:15 volumio volumio[928]: Error info: { Mar 17 00:16:15 volumio volumio[928]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id' Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: --------->(FetchError) request to https://www.youtube.com/api/lounge/pairing/generate_screen_id failed, reason: connect ETIMEDOUT 31.13.94.49:443 Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: AppError: Failed to start YouTubeApp Mar 17 00:16:15 volumio volumio[928]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:125:19) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Mar 17 00:16:15 volumio volumio[928]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Mar 17 00:16:15 volumio volumio[928]: LoungeScreenDisconnected { Mar 17 00:16:15 volumio volumio[928]: AID: null, Mar 17 00:16:15 volumio volumio[928]: name: 'loungeScreenDisconnected', Mar 17 00:16:15 volumio volumio[928]: payload: {} Mar 17 00:16:15 volumio volumio[928]: } Mar 17 00:16:15 volumio volumio[928]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Mar 17 00:16:15 volumio volumio[928]: Stack trace: Mar 17 00:16:15 volumio volumio[928]: IncompleteAPIDataError: Missing data required to construct query string from bind params Mar 17 00:16:15 volumio volumio[928]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Mar 17 00:16:15 volumio volumio[928]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Mar 17 00:16:15 volumio volumio[928]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Mar 17 00:16:15 volumio volumio[928]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Mar 17 00:16:15 volumio volumio[928]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Mar 17 00:16:15 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 17 00:16:15 volumio volumio[928]: at async /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:118:21 Mar 17 00:16:15 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:16:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Mar 17 00:16:15 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:16:15 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:16:15 volumio go-librespot[2217]: Librespot-go daemon starting... Mar 17 00:16:15 volumio go-librespot[2217]: time="2025-03-17T00:16:15+08:00" level=info msg="generated new device id: 9a8e1224c5feab5553d847b9efb1c9448b3f5a34" Mar 17 00:16:15 volumio go-librespot[2217]: time="2025-03-17T00:16:15+08:00" level=debug msg="stored credentials not found" Mar 17 00:16:15 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:15 volumio volumio[928]: info: CURURI: genres://Acid%20Punk Mar 17 00:16:15 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:15 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:16 volumio go-librespot[2217]: time="2025-03-17T00:16:16+08:00" level=debug msg="obtained new client token: AACpSyCUXlPjqa93c3DiydnyjhQFnmpBbJJ5ltT33/kbzXKUApcXC0D48TmcwRmwwGdRNYxPBDTAFBn08MbXgdHccZya0F3/apbUACyKBXQtHz9vSJmCRV6xHjLZrvUUEHRigpfrWdfiFotx+pqUsEVUZTZPx7ojhpsQLDaxPhbo3uG85hTDkaadnnINlZtwARQbd1mhaYeOFohyArHBgeWJngBy9tCf7ekKk3firr/4FDDDko8sBp+QIw1FdZI=" Mar 17 00:16:16 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:16 volumio go-librespot[2217]: time="2025-03-17T00:16:16+08:00" level=debug msg="new websocket client" Mar 17 00:16:16 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:16:17 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:17 volumio volumio[928]: info: CURURI: genres://Acid%20Punk/Beyond/Beyond%20%E6%80%80%E6%97%A7%E7%BB%8F%E5%85%B8%E9%87%91%E6%9B%B2%20Vol.%201 Mar 17 00:16:17 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:17 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/04_发烧女声/孙露 - 光辉岁月.mp3 Mar 17 00:16:17 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/04_发烧女声/孙露 - 光辉岁月.mp3 in service mpd Mar 17 00:16:17 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Beyond/Beyond%20%E6%80%80%E6%97%A7%E7%BB%8F%E5%85%B8%E9%87%91%E6%9B%B2%20Vol.%201/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%85%89%E8%BE%89%E5%B2%81%E6%9C%88.mp3&metadata=false Mar 17 00:16:17 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 光辉岁月.mp3 Mar 17 00:16:18 volumio go-librespot[2217]: time="2025-03-17T00:16:18+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]" Mar 17 00:16:18 volumio go-librespot[2217]: time="2025-03-17T00:16:18+08:00" level=debug msg="completed keyexchange" Mar 17 00:16:18 volumio go-librespot[2217]: time="2025-03-17T00:16:18+08:00" level=debug msg="completed challenge" Mar 17 00:16:18 volumio go-librespot[2217]: time="2025-03-17T00:16:18+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" Mar 17 00:16:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:16:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:16:18 volumio volumio[928]: info: Connection to go-librespot Websocket closed Mar 17 00:16:19 volumio volumio[928]: info: No valid Plugin REST Endpoint Mar 17 00:16:19 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:16:19 volumio volumio[928]: (node:928) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:19 volumio volumio[928]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Mar 17 00:16:19 volumio volumio[928]: (node:928) 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) Mar 17 00:16:19 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:16:19 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:19 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:19 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:21 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:21 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:21 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:16:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Mar 17 00:16:21 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:16:22 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:16:22 volumio go-librespot[2226]: Librespot-go daemon starting... Mar 17 00:16:22 volumio go-librespot[2226]: time="2025-03-17T00:16:22+08:00" level=info msg="generated new device id: 57312037795a6ca63b30bc96fbdb60857154002c" Mar 17 00:16:22 volumio go-librespot[2226]: time="2025-03-17T00:16:22+08:00" level=debug msg="stored credentials not found" Mar 17 00:16:22 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:16:22 volumio go-librespot[2226]: time="2025-03-17T00:16:22+08:00" level=debug msg="obtained new client token: AAAjGHtwugiAC7/S7mELeU/iYpiCHtixwxVhQW+pC/t91/QtsdDDgWB6juAzJzGmlIWPTzR6gJJbAnOik01J1kS4LJBq3pYnq8gn2POKJb0GS0FyE3VpKwhyYlCwk/dEAWRMSpN+hc6tcBLIyO/T8rsmWBOYtsU5WnbrrI16FlT9/iung7Ni1cVBZqTPzAKVgBf7UES17r3MbIRXJ2vWeC4lvx1XhOu+ONVwmpO9TTcuFZdbetWHNro0Yq/0LBmvRw==" Mar 17 00:16:23 volumio go-librespot[2226]: time="2025-03-17T00:16:23+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]" Mar 17 00:16:23 volumio go-librespot[2226]: time="2025-03-17T00:16:23+08:00" level=debug msg="completed keyexchange" Mar 17 00:16:23 volumio volumio[928]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/32eea007-dffb-4463-89c9-f8d7e7c99af0.jpg' Mar 17 00:16:23 volumio go-librespot[2226]: time="2025-03-17T00:16:23+08:00" level=debug msg="completed challenge" Mar 17 00:16:23 volumio go-librespot[2226]: time="2025-03-17T00:16: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" Mar 17 00:16:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 17 00:16:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 17 00:16:24 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:24 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 17 00:16:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 17 00:16:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Mar 17 00:16:26 volumio systemd[1]: Stopped go-librespot Daemon. Mar 17 00:16:27 volumio systemd[1]: Started go-librespot Daemon. Mar 17 00:16:27 volumio go-librespot[2234]: Librespot-go daemon starting... Mar 17 00:16:27 volumio go-librespot[2234]: time="2025-03-17T00:16:27+08:00" level=info msg="generated new device id: e7f15c018ba9dbcdfbd74424ccda6bc874090cbd" Mar 17 00:16:27 volumio go-librespot[2234]: time="2025-03-17T00:16:27+08:00" level=debug msg="stored credentials not found" Mar 17 00:16:27 volumio go-librespot[2234]: time="2025-03-17T00:16:27+08:00" level=debug msg="obtained new client token: AAA1QwzKQRIFhwWWU/Y/NOIYE1HPRpZxLQ6P6cS8NIl8oD7NwT/Tx/r96rbqthsSgCGrhgPvyLdgtVZRwtIPq9kFqneLJQaUCt2k/gWzn9hUWVKLTGnZ9Q1QRu16cj4XQV/8WThbExoicia/jXWOJfZWV4Srg0KVCCXHA7f3862J7XD+pK4H+86xmbesREXnaIM8sBuTUi1DiFaLbg/QZq+K3hqXoq9hYcGmZtvCxZOGiGSEriThLp1BxeDnKlecsA==" Mar 17 00:16:27 volumio volumio[928]: info: Initializing connection to go-librespot Websocket Mar 17 00:16:27 volumio go-librespot[2234]: time="2025-03-17T00:16:27+08:00" level=debug msg="new websocket client" Mar 17 00:16:27 volumio volumio[928]: info: Connection to go-librespot Websocket established Mar 17 00:16:28 volumio go-librespot[2234]: time="2025-03-17T00:16: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Mar 17 00:16:29 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:29 volumio volumio[928]: info: CURURI: music-library Mar 17 00:16:29 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:30 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:16:30 volumio volumio[928]: info: Getting Spotify volume Mar 17 00:16:30 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 17 00:16:30 volumio volumio[928]: info: CoreCommandRouter::volumioGetState Mar 17 00:16:30 volumio volumio[928]: info: CorePlayQueue::getTrack 0 Mar 17 00:16:30 volumio volumio[928]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Mar 17 00:16:33 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:33 volumio volumio[928]: info: CURURI: music-library/USB Mar 17 00:16:33 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:36 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 17 00:16:36 volumio volumio[928]: info: CURURI: music-library/USB/KINGSTON Mar 17 00:16:36 volumio volumio[928]: error: Cue Parser - Cannot parse USB/KINGSTON/CDImage.cue Mar 17 00:16:36 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/(1bit-2.8M)DSF格式测试.dsf Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/03 - 偏偏喜欢你.dff.dff Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/06_哀吟.dff Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/08_夢想歌.dff Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/14-泡沫の声.dff Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/DSD128.dff Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/常安 - 烟雨唱扬州.flac Mar 17 00:16:36 volumio volumio[928]: info: Preloading song: music-library/USB/KINGSTON/DSD256.dsf Mar 17 00:16:36 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/(1bit-2.8M)DSF格式测试.dsf in service mpd Mar 17 00:16:36 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Ian%20Shaw//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F(1bit-2.8M)DSF%E6%A0%BC%E5%BC%8F%E6%B5%8B%E8%AF%95.dsf&metadata=false Mar 17 00:16:36 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/(1bit-2.8M)DSF格式测试.dsf Mar 17 00:16:36 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/03 - 偏偏喜欢你.dff.dff in service mpd Mar 17 00:16:36 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F03%20-%20%E5%81%8F%E5%81%8F%E5%96%9C%E6%AC%A2%E4%BD%A0.dff.dff&metadata=false Mar 17 00:16:36 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/03 - 偏偏喜欢你.dff.dff Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/06_哀吟.dff in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F06_%E5%93%80%E5%90%9F.dff&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/06_哀吟.dff Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/08_夢想歌.dff in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F08_%E5%A4%A2%E6%83%B3%E6%AD%8C.dff&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/08_夢想歌.dff Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/14-泡沫の声.dff in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F14-%E6%B3%A1%E6%B2%AB%E3%81%AE%E5%A3%B0.dff&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/14-泡沫の声.dff Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/DSD128.dff in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FDSD128.dff&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/DSD128.dff Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/常安 - 烟雨唱扬州.flac in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%BA%AB%E4%B8%B4%E5%85%B6%E5%A2%83%E9%9F%B3%E4%B9%90%E9%A6%86/13951395167%E5%BE%AE%E4%BF%A1%E5%90%8C%E5%8F%B7/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%B8%B8%E5%AE%89%20-%20%E7%83%9F%E9%9B%A8%E5%94%B1%E6%89%AC%E5%B7%9E.flac&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/常安 - 烟雨唱扬州.flac Mar 17 00:16:37 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/DSD256.dsf in service mpd Mar 17 00:16:37 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Nidarosdomens%20jentekor%20%26%20TrondheimSolistene/MAGNIFICAT/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FDSD256.dsf&metadata=false Mar 17 00:16:37 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/DSD256.dsf Mar 17 00:16:38 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan Mar 17 00:16:40 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:40 volumio volumio[928]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 17 00:16:40 volumio volumio[928]: info: CoreStateMachine::ClearQueue Mar 17 00:16:40 volumio volumio[928]: info: CoreStateMachine::stop Mar 17 00:16:40 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 00:16:40 volumio volumio[928]: info: CorePlayQueue::clearPlayQueue Mar 17 00:16:40 volumio volumio[928]: info: CorePlayQueue::saveQueue Mar 17 00:16:40 volumio volumio[928]: info: CoreCommandRouter::volumioPushQueue Mar 17 00:16:40 volumio volumio[928]: info: CoreStateMachine::addQueueItems Mar 17 00:16:40 volumio volumio[928]: info: CorePlayQueue::addQueueItems Mar 17 00:16:40 volumio volumio[928]: info: Preload queue cleared Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/(1bit-2.8M)DSF格式测试.dsf Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/(1bit-2.8M)DSF格式测试.dsf Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/03 - 偏偏喜欢你.dff.dff Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/03 - 偏偏喜欢你.dff.dff Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/06_哀吟.dff Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/06_哀吟.dff Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/08_夢想歌.dff Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/08_夢想歌.dff Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/14-泡沫の声.dff Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/14-泡沫の声.dff Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/DSD128.dff Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/DSD128.dff Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/常安 - 烟雨唱扬州.flac Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/常安 - 烟雨唱扬州.flac Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/DSD256.dsf Mar 17 00:16:40 volumio volumio[928]: info: Using cached record of: music-library/USB/KINGSTON/DSD256.dsf Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/04_发烧女声 Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/04_发烧女声 in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/APE Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/APE in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/CDImage.cue Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/CDImage.cue in service mpd Mar 17 00:16:40 volumio volumio[928]: error: Invalid time format: 54:53:7 Mar 17 00:16:40 volumio volumio[928]: error: Cue Parser - Cannot parse /mnt/USB/KINGSTON/CDImage.cue Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/FLAC Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/FLAC in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后 Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后 in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/伟音测试文件 Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/伟音测试文件 in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV in service mpd Mar 17 00:16:40 volumio volumio[928]: info: Adding Item to queue: music-library/USB/KINGSTON/童丽 想念你 XRCD(日本版）[WAV+CUE] Mar 17 00:16:40 volumio volumio[928]: info: Exploding uri music-library/USB/KINGSTON/童丽 想念你 XRCD(日本版）[WAV+CUE] in service mpd Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%86%A0%E7%87%83%E9%9F%B3%E4%B9%90/%E6%88%B4%E8%89%BA%E7%91%B6/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F02%E8%B0%AD%E8%89%B3%20-%20%E5%85%89%E6%98%8E.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/02谭艳 - 光明.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%99%8E%E4%BA%8C/%E6%BC%82%E6%B4%8B%E8%BF%87%E6%B5%B7%E6%9D%A5%E7%9C%8B%E4%BD%A0/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F04%E5%AD%99%E9%9C%B2%20-%20%E6%BC%82%E6%B4%8B%E8%BF%87%E6%B5%B7%E6%9D%A5%E7%9C%8B%E4%BD%A0.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/04孙露 - 漂洋过海来看你.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%A9%A7%E9%92%B0%E5%84%BFJY/%E4%BC%A4%E4%BA%86%E5%BF%83%E7%9A%84%E5%A5%B3%E4%BA%BA%E6%80%8E%E4%B9%88%E4%BA%86%20%E7%94%B5%E8%A7%86%E5%89%A7%E3%80%8A%E8%B4%A4%E5%A6%BB%E3%80%8B%E6%8F%92%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F05%E8%B0%AD%E8%89%B3%20-%20%E4%BC%A4%E4%BA%86%E5%BF%83%E7%9A%84%E5%A5%B3%E4%BA%BA%E6%80%8E%E4%B9%88%E4%BA%86.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/05谭艳 - 伤了心的女人怎么了.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%A3%B0%E8%89%B2%E6%89%B0%E4%BA%BA/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F07%E5%AD%99%E9%9C%B2%20-%20%E7%A6%BB%E5%88%AB%E7%9A%84%E8%BD%A6%E7%AB%99.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/07孙露 - 离别的车站.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=W.K./%E6%88%91%E5%8F%AF%E4%BB%A5%E6%8A%B1%E4%BD%A0%E5%90%97/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F08%E5%AD%99%E9%9C%B2%20-%20%E6%88%91%E5%8F%AF%E4%BB%A5%E6%8A%B1%E4%BD%A0%E5%90%97.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/08孙露 - 我可以抱你吗.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E4%BA%91%E8%8F%B2%E8%8F%B2/%E5%B0%8F%E5%B0%8F%E6%96%B0%E5%A8%98%E8%8A%B1/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F09%E5%AD%99%E9%9C%B2%20-%20%E5%B0%8F%E5%B0%8F%E6%96%B0%E5%A8%98%E8%8A%B1.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/09孙露 - 小小新娘花.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E4%BA%A6%E5%8C%97%E6%99%A8%26DJ%E5%AE%81%E5%AE%81/%E4%B8%80%E8%BE%B9%E8%AF%B4%E7%88%B1%E6%88%91/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F10%E5%AD%99%E9%9C%B2%20-%20%E7%A7%8B%E5%A4%A9%E4%B8%8D%E5%9B%9E%E6%9D%A5.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/10孙露 - 秋天不回来.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E7%BC%A0%E7%BB%95/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F11%E5%AD%99%E9%9C%B2-%E5%A0%86%E7%A7%AF%E6%83%85%E6%84%9F-.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/11孙露-堆积情感-.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%AE%B8DaTou/%E7%BF%BB%E5%94%B1/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F13%E8%B0%AD%E8%89%B3%20-%20%E5%8D%97%E5%B1%B1%E5%8D%97.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/13谭艳 - 南山南.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%94%A1%E7%90%B4/%E8%AF%95%E9%9F%B3%20%E8%94%A1%E7%90%B4/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F14%E5%AD%99%E9%9C%B2%20-%20%E6%8A%8A%E6%82%B2%E4%BC%A4%E7%95%99%E7%BB%99%E8%87%AA%E5%B7%B1.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/14孙露 - 把悲伤留给自己.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%99%88%E5%86%AC%E9%9C%96/%E4%B8%8D%E8%A6%81%E5%86%8D%E6%9D%A5%E4%BC%A4%E5%AE%B3%E6%88%91%2F%E8%BF%99%E6%98%AF%E4%B8%BA%E4%BB%80%E4%B9%88/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F15%E5%AD%99%E9%9C%B2%20-%20%E4%B8%8D%E8%A6%81%E5%86%8D%E6%9D%A5%E4%BC%A4%E5%AE%B3%E6%88%91.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/15孙露 - 不要再来伤害我.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E8%B0%81%E4%B8%BA%E6%88%91%E5%81%9C%E7%95%99/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F17%E5%AD%99%E9%9C%B2%20-%20%E4%B8%BA%E4%BD%A0%E6%88%91%E5%8F%97%E5%86%B7%E9%A3%8E%E5%90%B9.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/17孙露 - 为你我受冷风吹.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%B0%8F%E6%B5%B7%E6%B5%B7/%E6%9B%BE%E7%BB%8F%E7%81%AB%E9%81%8D%E5%85%A8%E7%BD%91%E7%9A%84%E6%B5%81%E8%A1%8C%E9%9F%B3%E4%B9%90/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F18%E5%AD%99%E9%9C%B2%20-%20%E8%A2%AB%E4%BC%A4%E8%BF%87%E7%9A%84%E5%BF%83%E8%BF%98%E5%8F%AF%E4%BB%A5%E7%88%B1%E8%B0%81.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/18孙露 - 被伤过的心还可以爱谁.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=BOBO/BOBO%E6%AD%8C%E6%9B%B2%E5%90%88%E9%9B%86/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E4%B9%A0%E6%83%AF%E5%AF%82%E5%AF%9E.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 习惯寂寞.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9B%B9%E6%95%8F/%E4%BD%A0%E6%98%AF%E6%88%91%E4%BB%8A%E7%94%9F%E7%9A%84%E5%94%AF%E4%B8%80/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E4%BD%A0%E6%98%AF%E6%88%91%E4%BB%8A%E7%94%9F%E7%9A%84%E5%94%AF%E4%B8%80.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 你是我今生的唯一.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E2%98%9E%E5%B0%8F%E5%90%8D.%E7%B0%A7%E5%B1%B1%E2%99%A1/%E5%85%B6%E5%AE%9E%E9%9B%A8%E4%B9%9F%E6%B2%A1%E5%A4%9A%E5%A4%A7/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%81%87%E5%A6%82%E7%88%B1%E6%9C%89%E5%A4%A9%E6%84%8F.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 假如爱有天意.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Beyond/Beyond%20%E6%80%80%E6%97%A7%E7%BB%8F%E5%85%B8%E9%87%91%E6%9B%B2%20Vol.%201/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%85%89%E8%BE%89%E5%B2%81%E6%9C%88.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 光辉岁月.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%BE%A4%E6%98%9F/%E8%8C%B6%E9%9F%B5%E5%8F%A4%E7%AD%9DVOL.1/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%93%AD%E7%A0%82.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 哭砂.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E7%88%B1%E4%BA%BA%E5%88%AB%E8%B5%B0/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%9B%9A%E9%B8%9F.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 囚鸟.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E7%88%B1%E7%9A%84%E5%AF%82%E5%AF%9E%20(%E7%BF%BB%E5%94%B1)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%A4%9A%E6%83%B3%E6%8A%8A%E4%BD%A0%E6%8A%B1%E4%BD%8F.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 多想把你抱住.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E8%AF%95%E9%9F%B3%E5%AD%99%E9%9C%B2%20DXD/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%A5%B3%E4%BA%BA%E6%B3%AA.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 女人泪.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9D%8E%E4%BB%A3%E6%B2%AB/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%B8%80%E5%AD%A3%E6%BE%B3%E9%97%A8%E6%BC%94%E5%94%B1%E4%BC%9A/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%A6%82%E6%9E%9C%E6%B2%A1%E6%9C%89%E4%BD%A0.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 如果没有你.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E7%B2%BE%E9%80%892/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%AF%82%E5%AF%9E%E6%B2%99%E6%B4%B2%E5%86%B7.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 寂寞沙洲冷.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%8F%A6%E4%B8%80%E7%A7%8D%E6%83%85%E6%84%9F/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E5%AF%82%E5%AF%9E%E7%9A%84%E4%BA%BA%E5%AE%B9%E6%98%93%E9%86%89.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 寂寞的人容易醉.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%A3%8E%E7%9A%84%E7%B2%BE%E7%81%B5/%E8%81%86%E5%90%AC%E9%A3%8E%E5%90%B9%E8%BF%87%E7%9A%84%E5%A3%B0%E9%9F%B3/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E6%83%85%E6%AD%8C%E5%A5%BD%E5%90%AC%E5%8D%B4%E9%9A%BE%E5%94%B1.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 情歌好听却难唱.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=pico%E4%B9%90%E9%98%9F/%E4%B8%A4%E4%B8%AA%E4%BA%BA%E7%9A%84%E5%9B%9E%E5%BF%86%E4%B8%80%E4%B8%AA%E4%BA%BA%E8%BF%87/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E6%8C%AA%E5%A8%81%E7%9A%84%E6%A3%AE%E6%9E%97.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 挪威的森林.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%B1%BC%E9%B1%BC%E9%B1%BCOvO/%E9%B1%BC%E9%B1%BC%E9%B1%BCovo/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E6%A8%A1%E7%89%B9.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 模特.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9C%B1%E6%BD%AE%E5%8B%87%2F%E6%9D%A8%E5%BF%BB%E9%BB%98/%E6%B2%99%E6%BC%A0%E6%83%85%E6%AD%8C/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E6%B2%99%E6%BC%A0%E6%83%85%E6%AD%8C.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 沙漠情歌.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%8D%81%E5%A4%A7%E5%8D%8E%E8%AF%AD%E9%87%91%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E6%B5%AA%E4%BA%BA%E6%83%85%E6%AD%8C.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 浪人情歌.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E7%88%B1%E4%BA%BA%E5%88%AB%E8%B5%B0/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%94%B7%E4%BA%BA%E5%86%8D%E6%99%9A%E4%B9%9F%E5%88%AB%E5%BF%98%E4%BA%86%E5%9B%9E%E5%AE%B6.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 男人再晚也别忘了回家.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%BC%A0%E9%9D%93%E9%A2%96%2F%E5%8D%A2%E6%98%B6%E5%AE%87%2F%E7%8E%8B%E8%89%BA%E9%99%B6%2F%E6%9D%8E%E7%A7%89%E6%88%90/%E6%88%91%E6%83%B3%E5%92%8C%E4%BD%A0%E5%94%B1%20%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC6%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%94%BB%E5%BF%83.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 画心.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%A4%A7%E5%A4%A9%E4%BD%BF%20icey/%E7%A6%BB%E4%BA%BA%20%EF%BC%88Cover%20%E6%9E%97%E5%BF%97%E7%82%AB%EF%BC%89/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%A6%BB%E4%BA%BA.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 离人.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%AF%B8%E6%B1%9F/%E8%AF%B8%E6%B1%9F%E7%BB%8F%E5%85%B8%E8%80%81%E6%AD%8C%E7%B2%BE%E9%80%89/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%AD%89%E4%BD%A0%E7%AD%89%E4%BA%86%E9%82%A3%E4%B9%88%E4%B9%85.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 等你等了那么久.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%8E%9F%E6%9D%A5%E7%9A%84%E6%88%91/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%BB%93%E6%9D%9F%E4%B8%8D%E6%98%AF%E6%88%91%E8%A6%81%E7%9A%84%E7%BB%93%E6%9E%9C.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 结束不是我要的结果.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E6%92%A9%E4%BA%BA/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E7%BB%99%E4%BD%A0%E4%BB%AC.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 给你们.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E4%B8%80%E7%B1%B3%E9%98%B3%E5%85%89%E9%9F%B3%E4%B9%90%E5%8F%B0/%E6%8A%96%E9%9F%B3%E7%A5%9E%E6%9B%B2%E6%AD%8C%E5%8D%952022%E6%9C%80%E7%81%AB/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%80%81%E6%9C%89%E6%89%80%E4%BE%9D.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 老有所依.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%BE%A4%E6%98%9F/%E6%B1%BD%E8%BD%A6Hi-Fi%E9%9F%B3%E4%B9%90%201/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%8F%8A%E8%8A%B1%E5%8F%B0.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 菊花台.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%BE%A4%E6%98%9F/%E5%A6%99%E9%9F%B3%E7%94%9F%E8%8A%B1/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%93%9D%E8%8E%B2%E8%8A%B1.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 蓝莲花.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%91%A8%E5%8D%8E%E5%81%A5/%E8%AE%A9%E6%88%91%E6%AC%A2%E5%96%9C%E8%AE%A9%E6%88%91%E5%BF%A7/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%AE%A9%E6%88%91%E6%AC%A2%E5%96%9C%E8%AE%A9%E6%88%91%E5%BF%A7.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 让我欢喜让我忧.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%99%E9%9C%B2/%E5%8D%81%E5%A4%A7%E5%8D%8E%E8%AF%AD%E9%87%91%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%B6%81%E6%97%A9.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 趁早.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9D%8E%E6%98%8E%E5%8E%9F/%E8%B7%AF%E8%BF%87%E7%9A%84%E5%B9%B8%E7%A6%8F/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E8%B7%AF%E8%BF%87%E7%9A%84%E5%B9%B8%E7%A6%8F.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 路过的幸福.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%85%B3%E5%96%86/%E9%BB%91%E7%99%BD/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%AD%99%E9%9C%B2%20-%20%E9%BB%91%E7%99%BD%E8%8D%A7%E5%B9%95.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/孙露 - 黑白荧幕.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=pico%E4%B9%90%E9%98%9F/%E4%B8%A4%E4%B8%AA%E4%BA%BA%E7%9A%84%E5%9B%9E%E5%BF%86%E4%B8%80%E4%B8%AA%E4%BA%BA%E8%BF%87/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E5%BC%A0%E7%8E%AE%E4%BC%BD%20-%20%E6%8C%AA%E5%A8%81%E7%9A%84%E6%A3%AE%E6%9E%97.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/张玮伽 - 挪威的森林.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9E%97%E8%8A%B8%2F%E6%B1%9F%E5%BF%B5%E5%BA%AD/%E5%86%AC%E4%B9%8B%E7%A5%AD/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E8%B0%AD%E8%89%B3%20-%20%E6%9C%80%E5%90%8E%E4%B8%80%E5%A4%9C.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/谭艳 - 最后一夜.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%8E%8B%E6%9D%B0/%E6%88%91/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E8%B0%AD%E8%89%B3%20-%20%E7%BA%A2%E5%B0%98%E6%9C%89%E4%BD%A0.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/谭艳 - 红尘有你.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Eliauk/%E8%8E%AB%E6%96%AF%E7%A7%91%E9%83%8A%E5%A4%96%E7%9A%84%E5%A4%9C%E6%99%9A/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E9%9B%B7%E5%A9%B7%20-%20%E5%88%86%E6%89%8B%E5%9C%A8%E9%82%A3%E4%B8%AA%E7%A7%8B%E5%A4%A9.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/雷婷 - 分手在那个秋天.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9B%BE%E4%B9%90%E5%BD%A4/%E5%AD%98%E5%9C%A8/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F04_%E5%8F%91%E7%83%A7%E5%A5%B3%E5%A3%B0%2F%E9%9B%B7%E5%A9%B7%20-%20%E5%AD%98%E5%9C%A8.mp3&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/04_发烧女声/雷婷 - 存在.mp3 Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%B4%9D%E7%93%A6%E5%84%BF%E6%AD%8C/3%E5%B2%81%E5%84%BF%E6%AD%8C/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2F04_Psy%20-%20%E6%B1%9F%E5%8D%97Style.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/04_Psy - 江南Style.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=G.E.M.%E9%82%93%E7%B4%AB%E6%A3%8B/Xposed/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2F07_%E9%82%93%E7%B4%AB%E6%A3%8B%20-%20%E6%B3%A1%E6%B2%AB.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/07_邓紫棋 - 泡沫.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%B5%A9%E5%AE%9D/%E2%80%9C%E7%B2%A4%E8%AF%AD%E2%80%9D%E5%97%A8%E6%9B%B2DJ%E5%86%A0%E5%86%9B%20-%20%E8%BD%A6%E8%BD%BD%E9%87%8D%E4%BD%8E%E9%9F%B3/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2F10_%E9%82%93%E7%B4%AB%E6%A3%8B%20-%20%E5%96%9C%E6%AC%A2%E4%BD%A0.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/10_邓紫棋 - 喜欢你.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9D%8E%E6%99%93%E6%9D%B0/%E8%80%81%E5%A4%A7/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2F12_%E6%9D%8E%E6%99%93%E6%9D%B0%20-%20%E6%9C%8B%E5%8F%8B%E7%9A%84%E9%85%92.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/12_李晓杰 - 朋友的酒.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=A-Lin/%E6%88%91%E6%98%AF%E6%AD%8C%E6%89%8B%E7%AC%AC%E4%B8%89%E5%AD%A3%20%E7%AC%AC1%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2FA%20Lin%20-%20%E7%BB%99%E6%88%91%E4%B8%80%E4%B8%AA%E7%90%86%E7%94%B1%E5%BF%98%E8%AE%B0.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/A Lin - 给我一个理由忘记.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%94%A1%E7%90%B4/%E7%88%B1%E5%83%8F%E4%B8%80%E9%A6%96%E6%AD%8C/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FAPE%2F%E8%94%A1%E7%90%B4.-.%5B%E7%88%B1%E5%83%8F%E4%B8%80%E9%A6%96%E6%AD%8C%5D.%E4%B8%93%E8%BE%91.(ape).ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/APE/蔡琴.-.[爱像一首歌].专辑.(ape).ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%99%88%E7%BF%94/My%20Stage/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FFLAC%2F06_%E9%99%88%E7%BF%94%20-%20%E7%83%9F%E7%81%AB.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/FLAC/06_陈翔 - 烟火.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=Zero%20Cult/Inside%20Out/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FFLAC%2FZero%20Cult%20-%20Where%20Is%20No%20One%20Around.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/FLAC/Zero Cult - Where Is No One Around.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%82%93%E8%B6%85/%E5%A8%98%E5%A8%98%E6%88%91%E9%94%99%E4%BA%86/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FFLAC%2F%E9%82%93%E8%B6%85%20-%20%E5%A8%98%E5%A8%98%E6%88%91%E9%94%99%E4%BA%86.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/FLAC/邓超 - 娘娘我错了.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%87%91%E8%8E%8E/%E6%98%9F%E6%9C%88%E7%A5%9E%E8%AF%9D/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FFLAC%2F%E9%87%91%E8%8E%8E.-.%5B%E6%98%9F%E6%9C%88%E7%A5%9E%E8%AF%9D%5D.%E4%B8%93%E8%BE%91..flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/FLAC/金莎.-.[星月神话].专辑..flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F01.%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/01.浪迹天涯.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F02.%E8%AF%BB%E4%BD%A0.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/02.读你.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F03.%E7%97%B4%E7%97%B4%E7%9A%84%E7%AD%89.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/03.痴痴的等.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F04.%E7%A9%BA%E7%AD%89.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/04.空等.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F05.%E6%96%9C%E9%98%B3%E5%A4%96.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/05.斜阳外.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F06.%E4%B8%8D%E5%BA%94%E8%AF%A5.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/06.不应该.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F07.%E7%99%BD%E9%87%91%E5%8D%81%E5%AD%97%E9%93%BE.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/07.白金十字链.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F08.%E6%B5%AE%E6%B0%B4%E5%8D%B0.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/08.浮水印.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F09.%E6%83%85%E4%BA%BA%E7%9A%84%E7%9C%BC%E6%B3%AA.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/09.情人的眼泪.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F10.%E6%A2%A6%E4%B8%AD%E4%BA%BA.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/10.梦中人.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F11.%E9%9B%A8%E8%99%BD%E6%97%A0%E6%83%85%E4%BD%A0%E6%9C%89%E6%83%85.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/11.雨虽无情你有情.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BA%91%E8%8E%BA%E5%94%B1%E7%89%87-%5B%E9%87%91%E7%89%8C%E5%B0%8F%E5%8F%B7-%E6%B5%AA%E8%BF%B9%E5%A4%A9%E6%B6%AF-%E5%A4%84%E7%90%86%E5%90%8E%2F12.%E5%90%9B%E6%97%A0%E6%84%81.flac&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/云莺唱片-[金牌小号-浪迹天涯-处理后/12.君无愁.flac Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FDSD128.dff&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/DSD128.dff Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FDSD256.dff&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/DSD256.dff Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FDSD512.dff&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/DSD512.dff Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=White%20Zombie/Let%20Sleeping%20Corpses%20Lie/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FSUMMER%20VIBE_768kHz32bit_Beagle%20Kick.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/SUMMER VIBE_768kHz32bit_Beagle Kick.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack01.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track01.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack02.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track02.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack03.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track03.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack04.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track04.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack05.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track05.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack06.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track06.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack07.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track07.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack08.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track08.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2FTrack12.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/Track12.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%AD%9F%E5%BA%AD%E8%8B%87/%E8%B0%81%E7%9A%84%E7%9C%BC%E6%B3%AA%E5%9C%A8%E9%A3%9E/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E5%AD%9F%E5%BA%AD%E8%8B%87%20-%20%E5%8E%9F%E6%9C%AC%E4%BB%8A%E7%94%9F%E4%BB%A5%E4%B8%BA.ape&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/孟庭苇 - 原本今生以为.ape Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-176K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-176K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-192K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-192K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-352K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-352K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-384K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-384K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-44K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-44K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-48K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-48K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-705K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-705K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-88K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-88K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E4%BC%9F%E9%9F%B3%E6%B5%8B%E8%AF%95%E6%96%87%E4%BB%B6%2F%E7%8E%8B%E8%8F%B2-%E5%A4%A9%E7%A9%BA-96K.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/伟音测试文件/王菲-天空-96K.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E7%BA%A2.%20%E5%A7%9A%E7%92%8E%E6%A0%BC/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F01%20%E9%80%81%E5%88%AB.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/01 送别.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E7%BA%A2.%20%E5%A7%9A%E7%92%8E%E6%A0%BC/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F02%20%E7%8F%8A%E7%91%9A%E9%A2%82.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/02 珊瑚颂.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E7%BA%A2.%20%E5%A7%9A%E7%92%8E%E6%A0%BC/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F03%20%E9%BC%93%E6%B5%AA%E5%B1%BF%E4%B9%8B%E6%B3%A2.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/03 鼓浪屿之波.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%88%80%E9%83%8E/%E6%8A%AB%E7%9D%80%E7%BE%8A%E7%9A%AE%E7%9A%84%E7%8B%BC/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F04%20%E9%A9%BC%E9%93%83.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/04 驼铃.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E5%85%B3%E7%89%A7%E6%9D%91//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F06%20%E6%84%BF%E5%81%9A%E8%9D%B4%E8%9D%B6%E6%AF%94%E7%BF%BC%E9%A3%9E.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/06 愿做蝴蝶比翼飞.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%83%91%E7%BB%AA%E5%B2%9A/%E4%B8%96%E7%BA%AA%E6%AD%8C%E5%85%B810/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F07%20%E5%A6%88%E5%A6%88%E7%95%99%E7%BB%99%E6%88%91%E4%B8%80%E9%A6%96%E6%AD%8C.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/07 妈妈留给我一首歌.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%82%96%E6%88%98/%E7%BE%8E%E4%B8%BD%E4%B8%AD%E5%9B%BD%E7%89%B9%E5%88%AB%E7%AF%87/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F08%20%E7%BA%A2%E6%A2%85%E8%B5%9E.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/08 红梅赞.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9D%8E%E8%B0%B7%E4%B8%80/%E5%8E%9F%E5%94%B1%E7%BB%8F%E5%85%B8%E5%90%8D%E6%9B%B2%E7%8F%8D%E8%97%8F7/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F09%20%E5%BF%83%E4%B8%AD%E7%9A%84%E7%8E%AB%E7%91%B0.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/09 心中的玫瑰.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E9%BB%84%E8%8B%B1/Cover%20Girls/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F10%20%E6%98%A0%E5%B1%B1%E7%BA%A2.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/10 映山红.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E8%89%BE%E5%B0%94%E8%82%AF-Erkin%20Abdulla/%E8%B5%B0%E5%87%BA%E6%B2%99%E6%BC%A0%E7%9A%84%E5%88%80%E9%83%8E/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F11%20%E8%8A%B1%E5%84%BF%E4%B8%BA%E4%BB%80%E4%B9%88%E8%BF%99%E6%A0%B7%E7%BA%A2.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/11 花儿为什么这样红.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E6%9D%8E%E8%B0%B7%E4%B8%80/%E4%B8%96%E7%BA%AA%E6%AD%8C%E5%85%B812/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E5%A7%9A%E7%92%8E%E6%A0%BC24K%E9%87%91CD.%E9%99%90%E9%87%8F%E7%AD%BE%E5%90%8D%E7%89%88%E3%80%8A%E7%BA%A2%E3%80%8BWAV%2F12%20%E7%BB%92%E8%8A%B1.wav&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/姚璎格24K金CD.限量签名版《红》WAV/12 绒花.wav Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%AB%A5%E4%B8%BD/%E6%83%B3%E5%BF%B5%E4%BD%A0XRCD/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E7%AB%A5%E4%B8%BD%20%E6%83%B3%E5%BF%B5%E4%BD%A0%20XRCD(%E6%97%A5%E6%9C%AC%E7%89%88%EF%BC%89%5BWAV%2BCUE%5D%2FCDImage.cue&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/童丽 想念你 XRCD(日本版）[WAV+CUE]/CDImage.cue Mar 17 00:16:40 volumio volumio[928]: info: ALBUMART /albumart?cacheid=378&web=%E7%AB%A5%E4%B8%BD/%E6%83%B3%E5%BF%B5%E4%BD%A0XRCD/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E7%AB%A5%E4%B8%BD%20%E6%83%B3%E5%BF%B5%E4%BD%A0%20XRCD(%E6%97%A5%E6%9C%AC%E7%89%88%EF%BC%89%5BWAV%2BCUE%5D%2FCDImage.cue&metadata=false Mar 17 00:16:40 volumio volumio[928]: info: URI /mnt/USB/KINGSTON/童丽 想念你 XRCD(日本版）[WAV+CUE]/CDImage.cue Mar 17 00:16:40 volumio volumio[928]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 17 00:16:40 volumio volumio[928]: Error: Unable to resolve or reject the same promise twice Mar 17 00:16:40 volumio volumio[928]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 17 00:16:40 volumio volumio[928]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Mar 17 00:16:40 volumio volumio[928]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 17 00:16:40 volumio volumio[928]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 17 00:16:40 volumio volumio[928]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 17 00:16:40 volumio volumio[928]: at Socket.emit (events.js:315:20) Mar 17 00:16:40 volumio volumio[928]: at addChunk (internal/streams/readable.js:309:12) Mar 17 00:16:40 volumio volumio[928]: at readableAddChunk (internal/streams/readable.js:280:11) Mar 17 00:16:40 volumio volumio[928]: at Socket.Readable.push (internal/streams/readable.js:223:10) Mar 17 00:16:40 volumio volumio[928]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Mar 17 00:16:40 volumio volumio[928]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 17 00:16:40 volumio sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-17 00:15 Mar 17 00:16:40 volumio sudo[2252]: 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"