-- Logs begin at Thu 2019-02-14 18:12:06 CST, end at Fri 2024-07-26 20:25:19 CST. -- Jul 26 20:24:00 volumio kernel: usb 1-1.1: USB disconnect, device number 4 Jul 26 20:24:00 volumio kernel: ch341-uart ttyUSB0: ch341-uart converter now disconnected from ttyUSB0 Jul 26 20:24:00 volumio kernel: ch341 1-1.1:1.0: device disconnected Jul 26 20:24:00 volumio kernel: usb 1-1.1: new high-speed USB device number 5 using xhci_hcd Jul 26 20:24:00 volumio kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.12 Jul 26 20:24:00 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 26 20:24:00 volumio kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 26 20:24:00 volumio kernel: usb 1-1.1: Manufacturer: SMSL Jul 26 20:24:01 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 26 20:24:01 volumio kernel: hid-generic 0003:152A:85DD.0002: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 26 20:24:01 volumio systemd-udevd[1591]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jul 26 20:24:01 volumio volumio[1024]: info: Jul 26 20:24:01 volumio volumio[1024]: ---------------------------- USB Audio Device Attached Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::Close All Modals sent Jul 26 20:24:01 volumio volumio[1024]: info: Preparing to save Alsa Options, stopping services first Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState Jul 26 20:24:01 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::volumioPause Jul 26 20:24:01 volumio volumio[1024]: info: CoreStateMachine::pause Jul 26 20:24:01 volumio volumio[1024]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:01 volumio volumio[1024]: info: Device 5 does not have any Mixer Control Available Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 26 20:24:01 volumio volumio[1024]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 26 20:24:01 volumio volumio[1024]: info: Disabling external Volume Control Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 26 20:24:01 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:01 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:01 volumio volumio[1024]: info: Preparing to generate the ALSA configuration file Jul 26 20:24:01 volumio volumio[1024]: info: Asound.conf file unchanged, so no further update is needed Jul 26 20:24:01 volumio volumio[1024]: info: Output device has changed, restarting MPD Jul 26 20:24:01 volumio sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 26 20:24:01 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:01 volumio volumio[1024]: info: Output device has changed, restarting Shairport Sync Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:01 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:01 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 26 20:24:01 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:01 volumio systemd[1]: Stopping Music Player Daemon... Jul 26 20:24:01 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:01 volumio ntpd[780]: Soliciting pool server 193.182.111.12 Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 26 20:24:01 volumio systemd[1]: mpd.service: Succeeded. Jul 26 20:24:01 volumio systemd[1]: Stopped Music Player Daemon. Jul 26 20:24:01 volumio volumio[1024]: info: MPD Permissions set Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:01 volumio volumio[1024]: info: Starting Shairport Sync Jul 26 20:24:01 volumio sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 26 20:24:01 volumio sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:01 volumio systemd[1]: Starting Music Player Daemon... Jul 26 20:24:01 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 26 20:24:01 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 26 20:24:01 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:01 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:01 volumio volumio[1024]: info: Shairport-Sync Started Jul 26 20:24:01 volumio sudo[1622]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 26 20:24:01 volumio sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:01 volumio sudo[1622]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:01 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 26 20:24:02 volumio mpd[1634]: Jul 26 20:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 26 20:24:02 volumio systemd[1]: Started Music Player Daemon. Jul 26 20:24:02 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:02 volumio volumio[1024]: error: updateQueue error: null Jul 26 20:24:02 volumio ntpd[780]: Soliciting pool server 193.182.111.141 Jul 26 20:24:04 volumio kernel: usb 1-1.1: USB disconnect, device number 5 Jul 26 20:24:04 volumio volumio[1024]: info: Jul 26 20:24:04 volumio volumio[1024]: ---------------------------- USB Audio Device Detached Jul 26 20:24:04 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 26 20:24:04 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:04 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 26 20:24:05 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 26 20:24:05 volumio volumio[1024]: info: CoreStateMachine::getcurrentVolume Jul 26 20:24:05 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume Jul 26 20:24:05 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:05 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:05 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:12 volumio kernel: usb 1-1.1: new high-speed USB device number 6 using xhci_hcd Jul 26 20:24:12 volumio kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.12 Jul 26 20:24:12 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 26 20:24:12 volumio kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 26 20:24:12 volumio kernel: usb 1-1.1: Manufacturer: SMSL Jul 26 20:24:12 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 26 20:24:12 volumio kernel: hid-generic 0003:152A:85DD.0003: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 26 20:24:12 volumio systemd-udevd[1642]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jul 26 20:24:13 volumio volumio[1024]: info: Jul 26 20:24:13 volumio volumio[1024]: ---------------------------- USB Audio Device Attached Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::Close All Modals sent Jul 26 20:24:13 volumio volumio[1024]: info: Preparing to save Alsa Options, stopping services first Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState Jul 26 20:24:13 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::volumioPause Jul 26 20:24:13 volumio volumio[1024]: info: CoreStateMachine::pause Jul 26 20:24:13 volumio volumio[1024]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:13 volumio volumio[1024]: info: Device 5 does not have any Mixer Control Available Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 26 20:24:13 volumio volumio[1024]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 26 20:24:13 volumio volumio[1024]: info: Disabling external Volume Control Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 26 20:24:13 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:13 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:13 volumio kernel: usb 1-1.1: USB disconnect, device number 6 Jul 26 20:24:13 volumio volumio[1024]: info: Preparing to generate the ALSA configuration file Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:13 volumio volumio[1024]: Invalid card number. Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 26 20:24:13 volumio volumio[1024]: info: Asound.conf file unchanged, so no further update is needed Jul 26 20:24:13 volumio volumio[1024]: info: Output device has changed, restarting MPD Jul 26 20:24:13 volumio volumio[1024]: info: Output device has changed, restarting Shairport Sync Jul 26 20:24:13 volumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:13 volumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:13 volumio sudo[1668]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:13 volumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 26 20:24:13 volumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:13 volumio systemd[1]: Stopping Music Player Daemon... Jul 26 20:24:13 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 26 20:24:13 volumio volumio[1024]: info: MPD Permissions set Jul 26 20:24:13 volumio volumio[1024]: info: Jul 26 20:24:13 volumio volumio[1024]: ---------------------------- USB Audio Device Detached Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:13 volumio systemd[1]: mpd.service: Succeeded. Jul 26 20:24:13 volumio systemd[1]: Stopped Music Player Daemon. Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:13 volumio volumio[1024]: info: Starting Shairport Sync Jul 26 20:24:13 volumio systemd[1]: Starting Music Player Daemon... Jul 26 20:24:13 volumio sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 26 20:24:13 volumio sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 26 20:24:13 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 26 20:24:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:13 volumio sudo[1684]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:13 volumio volumio[1024]: info: Shairport-Sync Started Jul 26 20:24:13 volumio sudo[1677]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 26 20:24:13 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:13 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:13 volumio kernel: usb 1-1.1: new high-speed USB device number 7 using xhci_hcd Jul 26 20:24:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 26 20:24:13 volumio kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.12 Jul 26 20:24:13 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 26 20:24:13 volumio kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 26 20:24:13 volumio kernel: usb 1-1.1: Manufacturer: SMSL Jul 26 20:24:14 volumio mpd[1688]: Jul 26 20:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 26 20:24:14 volumio systemd[1]: Started Music Player Daemon. Jul 26 20:24:14 volumio sudo[1670]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:14 volumio volumio[1024]: error: updateQueue error: null Jul 26 20:24:14 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 26 20:24:14 volumio kernel: hid-generic 0003:152A:85DD.0004: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 26 20:24:14 volumio systemd-udevd[1643]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jul 26 20:24:14 volumio volumio[1024]: info: Jul 26 20:24:14 volumio volumio[1024]: ---------------------------- USB Audio Device Attached Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::Close All Modals sent Jul 26 20:24:14 volumio volumio[1024]: info: Preparing to save Alsa Options, stopping services first Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::volumioGetState Jul 26 20:24:14 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::volumioPause Jul 26 20:24:14 volumio volumio[1024]: info: CoreStateMachine::pause Jul 26 20:24:14 volumio volumio[1024]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:14 volumio volumio[1024]: info: Device 5 does not have any Mixer Control Available Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 26 20:24:14 volumio volumio[1024]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 26 20:24:14 volumio volumio[1024]: info: Disabling external Volume Control Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 26 20:24:14 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:14 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:14 volumio volumio[1024]: info: Preparing to generate the ALSA configuration file Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 26 20:24:14 volumio volumio[1024]: info: Asound.conf file unchanged, so no further update is needed Jul 26 20:24:14 volumio volumio[1024]: info: Output device has changed, restarting MPD Jul 26 20:24:14 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 26 20:24:14 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:14 volumio volumio[1024]: info: Output device has changed, restarting Shairport Sync Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:14 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:14 volumio sudo[1714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 26 20:24:14 volumio sudo[1714]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:14 volumio systemd[1]: Stopping Music Player Daemon... Jul 26 20:24:14 volumio volumio[1024]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 26 20:24:14 volumio systemd[1]: mpd.service: Succeeded. Jul 26 20:24:14 volumio volumio[1024]: info: MPD Permissions set Jul 26 20:24:14 volumio systemd[1]: Stopped Music Player Daemon. Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 26 20:24:14 volumio volumio[1024]: info: Starting Shairport Sync Jul 26 20:24:14 volumio sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 26 20:24:14 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:14 volumio systemd[1]: Starting Music Player Daemon... Jul 26 20:24:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 26 20:24:14 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 26 20:24:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 26 20:24:14 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:14 volumio volumio[1024]: info: Shairport-Sync Started Jul 26 20:24:14 volumio sudo[1720]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 26 20:24:14 volumio sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 20:24:14 volumio sudo[1720]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:14 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 26 20:24:15 volumio mpd[1732]: Jul 26 20:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 26 20:24:15 volumio systemd[1]: Started Music Player Daemon. Jul 26 20:24:15 volumio sudo[1714]: pam_unix(sudo:session): session closed for user root Jul 26 20:24:15 volumio volumio[1024]: error: updateQueue error: null Jul 26 20:24:17 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 26 20:24:17 volumio volumio[1024]: info: CoreStateMachine::getcurrentVolume Jul 26 20:24:17 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume Jul 26 20:24:17 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:17 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:17 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::getcurrentVolume Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioRetrievevolume Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:18 volumio volumio[1024]: info: Preload queue cleared Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::ClearQueue Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::stop Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::stPlaybackTimer Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::serviceStop Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrack 4 Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::serviceStop Jul 26 20:24:18 volumio volumio[1024]: info: ControllerMpd::stop Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::clearPlayQueue Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::saveQueue Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioPushQueue Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::addQueueItems Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::addQueueItems Jul 26 20:24:18 volumio volumio[1024]: info: Preload queue cleared Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 七里香.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 七里香.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 乱舞春秋.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 乱舞春秋.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 园游会.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 园游会.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 困兽之斗.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 困兽之斗.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 外婆.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 外婆.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 将军.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 将军.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 我的地盘.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 我的地盘.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 搁浅.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 搁浅.flac Jul 26 20:24:18 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 止战之殇.flac Jul 26 20:24:18 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 止战之殇.flac Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioPushQueue Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::saveQueue Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock Jul 26 20:24:18 volumio volumio[1024]: info: CoreCommandRouter::volumioPlay Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::play index 2 Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::stop Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::play index undefined Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:18 volumio volumio[1024]: info: CoreStateMachine::startPlaybackTimer Jul 26 20:24:18 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 20:24:18 volumio volumio[1024]: info: sendMpdCommand stop took 19 milliseconds Jul 26 20:24:18 volumio volumio[1024]: info: sendMpdCommand stop took 3 milliseconds Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 20:24:18 volumio volumio[1024]: info: Jul 26 20:24:18 volumio volumio[1024]: ---------------------------- MPD announces system playlist update Jul 26 20:24:18 volumio volumio[1024]: info: Ignoring MPD Status Update Jul 26 20:24:18 volumio volumio[1024]: info: sendMpdCommand clear took 2 milliseconds Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac" Jul 26 20:24:18 volumio volumio[1024]: error: updateQueue error: null Jul 26 20:24:18 volumio volumio[1024]: info: Jul 26 20:24:18 volumio volumio[1024]: ---------------------------- MPD announces system playlist update Jul 26 20:24:18 volumio volumio[1024]: info: Ignoring MPD Status Update Jul 26 20:24:18 volumio volumio[1024]: info: ------------------------------ 2ms Jul 26 20:24:18 volumio volumio[1024]: info: sendMpdCommand add "USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac" took 1 milliseconds Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand play Jul 26 20:24:18 volumio volumio[1024]: info: Jul 26 20:24:18 volumio volumio[1024]: ---------------------------- MPD announces state update: player Jul 26 20:24:18 volumio volumio[1024]: info: ------------------------------ 6ms Jul 26 20:24:18 volumio volumio[1024]: info: sendMpdCommand play took 5 milliseconds Jul 26 20:24:18 volumio volumio[1024]: info: ControllerMpd::getState Jul 26 20:24:18 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand status Jul 26 20:24:19 volumio volumio[1024]: info: Jul 26 20:24:19 volumio volumio[1024]: ---------------------------- MPD announces state update: player Jul 26 20:24:19 volumio volumio[1024]: info: sendMpdCommand status took 30 milliseconds Jul 26 20:24:19 volumio volumio[1024]: info: ControllerMpd::getState Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand status Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::parseState Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 20:24:19 volumio volumio[1024]: info: sendMpdCommand status took 3 milliseconds Jul 26 20:24:19 volumio volumio[1024]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::parseState Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::parseTrackInfo Jul 26 20:24:19 volumio volumio[1024]: info: ControllerMpd::pushState Jul 26 20:24:19 volumio volumio[1024]: info: CoreCommandRouter::servicePushState Jul 26 20:24:19 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:19 volumio volumio[1024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"517 Kbps","isStreaming":false,"title":"借口","artist":"周杰伦","album":"七里香","uri":"USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac","trackType":"flac"} Jul 26 20:24:19 volumio volumio[1024]: verbose: CURRENT POSITION 2 Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::syncState stateService play Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::syncState currentStatus stop Jul 26 20:24:19 volumio volumio[1024]: info: ------------------------------ 38ms Jul 26 20:24:19 volumio volumio[1024]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 26 20:24:19 volumio volumio[1024]: verbose: ControllerMpd::parseTrackInfo Jul 26 20:24:19 volumio volumio[1024]: info: ControllerMpd::pushState Jul 26 20:24:19 volumio volumio[1024]: info: CoreCommandRouter::servicePushState Jul 26 20:24:19 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:19 volumio volumio[1024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"534 Kbps","isStreaming":false,"title":"借口","artist":"周杰伦","album":"七里香","uri":"USB/新加卷/周杰伦 - 全部（无损flac）/七里香/周杰伦 - 借口.flac","trackType":"flac"} Jul 26 20:24:19 volumio volumio[1024]: verbose: CURRENT POSITION 2 Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::syncState stateService play Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::syncState currentStatus play Jul 26 20:24:19 volumio volumio[1024]: info: Received an update from plugin. extracting info from payload Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:19 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:19 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 20:24:19 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:19 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:24:19 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:24:19 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:24:19 volumio volumio[1024]: info: ------------------------------ 26ms Jul 26 20:25:13 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 26 20:25:13 volumio volumio[1024]: info: CURURI: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦 Jul 26 20:25:13 volumio volumio[1024]: info: Preload queue cleared Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 一路向北.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 夜曲.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 枫.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 蓝色风暴.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 逆鳞.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 飘移.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 麦芽糖.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 黑色毛衣.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦、梁心颐 - 珊瑚海.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 四面楚歌.flac Jul 26 20:25:13 volumio volumio[1024]: info: Preloading song: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 浪漫手机.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 一路向北.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E4%B8%80%E8%B7%AF%E5%90%91%E5%8C%97.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 一路向北.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%8F%91%E5%A6%82%E9%9B%AA.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 夜曲.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%A4%9C%E6%9B%B2.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 夜曲.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 枫.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E6%9E%AB.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 枫.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 蓝色风暴.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E8%93%9D%E8%89%B2%E9%A3%8E%E6%9A%B4.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 蓝色风暴.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 逆鳞.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E9%80%86%E9%B3%9E.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 逆鳞.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 飘移.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E9%A3%98%E7%A7%BB.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 飘移.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 麦芽糖.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E9%BA%A6%E8%8A%BD%E7%B3%96.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 麦芽糖.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 黑色毛衣.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E9%BB%91%E8%89%B2%E6%AF%9B%E8%A1%A3.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 黑色毛衣.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦、梁心颐 - 珊瑚海.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6%E3%80%81%E6%A2%81%E5%BF%83%E9%A2%90/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%E3%80%81%E6%A2%81%E5%BF%83%E9%A2%90%20-%20%E7%8F%8A%E7%91%9A%E6%B5%B7.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦、梁心颐 - 珊瑚海.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 四面楚歌.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%9B%9B%E9%9D%A2%E6%A5%9A%E6%AD%8C.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 四面楚歌.flac Jul 26 20:25:13 volumio volumio[1024]: info: Exploding uri music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 浪漫手机.flac in service mpd Jul 26 20:25:13 volumio volumio[1024]: info: ALBUMART /albumart?cacheid=174&web=%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6/extralarge&path=%2Fmnt%2FUSB%2F%E6%96%B0%E5%8A%A0%E5%8D%B7%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E5%85%A8%E9%83%A8%EF%BC%88%E6%97%A0%E6%8D%9Fflac%EF%BC%89%2F%E5%8D%81%E4%B8%80%E6%9C%88%E7%9A%84%E8%90%A7%E9%82%A6%2F%E5%91%A8%E6%9D%B0%E4%BC%A6%20-%20%E6%B5%AA%E6%BC%AB%E6%89%8B%E6%9C%BA.flac&metadata=false Jul 26 20:25:13 volumio volumio[1024]: info: URI /mnt/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 浪漫手机.flac Jul 26 20:25:15 volumio volumio[1024]: info: Preload queue cleared Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::ClearQueue Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::stop Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::stPlaybackTimer Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::serviceStop Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 2 Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::serviceStop Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::stop Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::clearPlayQueue Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::saveQueue Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPushQueue Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::addQueueItems Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::addQueueItems Jul 26 20:25:15 volumio volumio[1024]: info: Preload queue cleared Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 一路向北.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 一路向北.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 夜曲.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 夜曲.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 枫.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 枫.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 蓝色风暴.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 蓝色风暴.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 逆鳞.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 逆鳞.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 飘移.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 飘移.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 麦芽糖.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 麦芽糖.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 黑色毛衣.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 黑色毛衣.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦、梁心颐 - 珊瑚海.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦、梁心颐 - 珊瑚海.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 四面楚歌.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 四面楚歌.flac Jul 26 20:25:15 volumio volumio[1024]: info: Adding Item to queue: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 浪漫手机.flac Jul 26 20:25:15 volumio volumio[1024]: info: Using cached record of: music-library/USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 浪漫手机.flac Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPushQueue Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::saveQueue Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::updateTrackBlock Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrackBlock Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPlay Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::play index 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::stop Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::play index undefined Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::startPlaybackTimer Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 20:25:15 volumio volumio[1024]: info: Jul 26 20:25:15 volumio volumio[1024]: ---------------------------- MPD announces state update: player Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand stop took 22 milliseconds Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::getState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand status Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand stop took 4 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 20:25:15 volumio volumio[1024]: info: Jul 26 20:25:15 volumio volumio[1024]: ---------------------------- MPD announces system playlist update Jul 26 20:25:15 volumio volumio[1024]: info: Ignoring MPD Status Update Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand status took 3 milliseconds Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand clear took 2 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac" Jul 26 20:25:15 volumio volumio[1024]: error: updateQueue error: null Jul 26 20:25:15 volumio volumio[1024]: info: Jul 26 20:25:15 volumio volumio[1024]: ---------------------------- MPD announces system playlist update Jul 26 20:25:15 volumio volumio[1024]: info: Ignoring MPD Status Update Jul 26 20:25:15 volumio volumio[1024]: info: ------------------------------ 3ms Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand add "USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac" took 2 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseTrackInfo Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand play Jul 26 20:25:15 volumio volumio[1024]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 26 20:25:15 volumio volumio[1024]: info: ------------------------------ 8ms Jul 26 20:25:15 volumio volumio[1024]: info: Jul 26 20:25:15 volumio volumio[1024]: ---------------------------- MPD announces state update: player Jul 26 20:25:15 volumio volumio[1024]: info: ------------------------------ 7ms Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand play took 7 milliseconds Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::getState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand status Jul 26 20:25:15 volumio volumio[1024]: info: Jul 26 20:25:15 volumio volumio[1024]: ---------------------------- MPD announces state update: player Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::getState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand status Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand status took 2 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand status took 2 milliseconds Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseState Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseTrackInfo Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::pushState Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::servicePushState Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"723 Kbps","isStreaming":false,"title":"发如雪","artist":"周杰伦","album":"十一月的萧邦","uri":"USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac","trackType":"flac"} Jul 26 20:25:15 volumio volumio[1024]: verbose: CURRENT POSITION 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::syncState stateService play Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::syncState currentStatus stop Jul 26 20:25:15 volumio volumio[1024]: info: ------------------------------ 8ms Jul 26 20:25:15 volumio volumio[1024]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 20:25:15 volumio volumio[1024]: verbose: ControllerMpd::parseTrackInfo Jul 26 20:25:15 volumio volumio[1024]: info: ControllerMpd::pushState Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::servicePushState Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"766 Kbps","isStreaming":false,"title":"发如雪","artist":"周杰伦","album":"十一月的萧邦","uri":"USB/新加卷/周杰伦 - 全部（无损flac）/十一月的萧邦/周杰伦 - 发如雪.flac","trackType":"flac"} Jul 26 20:25:15 volumio volumio[1024]: verbose: CURRENT POSITION 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::syncState stateService play Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::syncState currentStatus play Jul 26 20:25:15 volumio volumio[1024]: info: Received an update from plugin. extracting info from payload Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:25:15 volumio volumio[1024]: info: CoreStateMachine::pushState Jul 26 20:25:15 volumio volumio[1024]: info: CorePlayQueue::getTrack 1 Jul 26 20:25:15 volumio volumio[1024]: info: CoreCommandRouter::volumioPushState Jul 26 20:25:16 volumio volumio[1024]: info: ------------------------------ 31ms Jul 26 20:25:18 volumio volumio[1024]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 20:25:18 volumio volumio[1024]: Error: connect ETIMEDOUT 159.138.20.20:443 Jul 26 20:25:18 volumio volumio[1024]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 26 20:25:18 volumio volumio[1024]: errno: -110, Jul 26 20:25:18 volumio volumio[1024]: code: 'ETIMEDOUT', Jul 26 20:25:18 volumio volumio[1024]: syscall: 'connect', Jul 26 20:25:18 volumio volumio[1024]: address: '159.138.20.20', Jul 26 20:25:18 volumio volumio[1024]: port: 443 Jul 26 20:25:18 volumio volumio[1024]: } Jul 26 20:25:18 volumio volumio[1024]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 20:25:19 volumio sudo[1789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 20:24 Jul 26 20:25:19 volumio sudo[1789]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"