-- Logs begin at Thu 2024-07-18 11:51:11 CST, end at Thu 2024-07-18 12:13:38 CST. -- Jul 18 12:12:09 volumio kernel: usb 9-1: new full-speed USB device number 4 using xhci_hcd Jul 18 12:12:09 volumio kernel: usb 9-1: New USB device found, idVendor=0a12, idProduct=4010, bcdDevice=16.69 Jul 18 12:12:09 volumio kernel: usb 9-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Jul 18 12:12:09 volumio kernel: hub 9-1:1.0: USB hub found Jul 18 12:12:09 volumio kernel: hub 9-1:1.0: 4 ports detected Jul 18 12:12:09 volumio kernel: usb 9-1.1: new full-speed USB device number 5 using xhci_hcd Jul 18 12:12:10 volumio kernel: usb 9-1.1: New USB device found, idVendor=0a12, idProduct=4007, bcdDevice=19.70 Jul 18 12:12:10 volumio kernel: usb 9-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 18 12:12:10 volumio kernel: usb 9-1.1: Product: FiiO BTR7 Jul 18 12:12:10 volumio kernel: usb 9-1.1: Manufacturer: FiiO Jul 18 12:12:10 volumio kernel: usb 9-1.1: SerialNumber: ABCDEF0123456789 Jul 18 12:12:11 volumio kernel: hid-generic 0003:0A12:4007.0004: hiddev0,hidraw1: USB HID v1.11 Device [FiiO FiiO BTR7] on usb-0000:06:10.0-1.1/input2 Jul 18 12:12:11 volumio volumio[940]: info: Jul 18 12:12:11 volumio volumio[940]: ---------------------------- USB Audio Device Attached Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 18 12:12:11 volumio systemd-udevd[3494]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::Close All Modals sent Jul 18 12:12:11 volumio volumio[940]: info: Preparing to save Alsa Options, stopping services first Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::volumioGetState Jul 18 12:12:11 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::volumioPause Jul 18 12:12:11 volumio volumio[940]: info: CoreStateMachine::pause Jul 18 12:12:11 volumio volumio[940]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO BTR7","alsacard":"BTR7"},"i2s":false} Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 12:12:11 volumio volumio[940]: info: Setting mixer PCM for card FiiO BTR7 Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 18 12:12:11 volumio volumio[940]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO BTR7 Mixer: PCM Max Vol: 100 Vol Curve; linear Vol Steps: 1 Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 18 12:12:11 volumio volumio[940]: info: Disabling external Volume Control Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 12:12:11 volumio volumio[940]: info: Preparing to generate the ALSA configuration file Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 12:12:11 volumio volumio[940]: info: VolumeController:: Volume=53 Mute =false Jul 18 12:12:11 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:11 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:11 volumio volumio[940]: info: Asound.conf file written Jul 18 12:12:11 volumio sudo[3519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 18 12:12:11 volumio sudo[3519]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio sudo[3519]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: No state is present for card BTR7 Jul 18 12:12:11 volumio volumio[940]: Found hardware: "USB-Audio" "USB Mixer" "USB0a12:4007" "" "" Jul 18 12:12:11 volumio volumio[940]: Hardware is initialized using a generic method Jul 18 12:12:11 volumio volumio[940]: No state is present for card BTR7 Jul 18 12:12:11 volumio volumio[940]: info: Output device has changed, restarting MPD Jul 18 12:12:11 volumio sudo[3524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 12:12:11 volumio sudo[3524]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio sudo[3524]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: info: Output device has changed, restarting Shairport Sync Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:11 volumio sudo[3527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 12:12:11 volumio sudo[3527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio systemd[1]: Stopping Music Player Daemon... Jul 18 12:12:11 volumio volumio[940]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 12:12:11 volumio volumio[940]: info: Output device has changed, restarting MPD Jul 18 12:12:11 volumio systemd[1]: mpd.service: Succeeded. Jul 18 12:12:11 volumio systemd[1]: Stopped Music Player Daemon. Jul 18 12:12:11 volumio sudo[3533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 12:12:11 volumio sudo[3533]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio volumio[940]: info: Output device has changed, restarting Shairport Sync Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:11 volumio systemd[1]: Starting Music Player Daemon... Jul 18 12:12:11 volumio sudo[3533]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio sudo[3537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 12:12:11 volumio sudo[3537]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 18 12:12:11 volumio systemd[1]: mpd.service: Succeeded. Jul 18 12:12:11 volumio systemd[1]: Stopped Music Player Daemon. Jul 18 12:12:11 volumio systemd[1]: Starting Music Player Daemon... Jul 18 12:12:11 volumio volumio[940]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 12:12:11 volumio volumio[940]: info: MPD Permissions set Jul 18 12:12:11 volumio volumio[940]: info: MPD Permissions set Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 18 12:12:11 volumio sudo[3542]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 18 12:12:11 volumio sudo[3542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio sudo[3542]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 12:12:11 volumio volumio[940]: info: Starting Shairport Sync Jul 18 12:12:11 volumio volumio[940]: info: Starting Shairport Sync Jul 18 12:12:11 volumio sudo[3558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 12:12:11 volumio sudo[3558]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio sudo[3561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 12:12:11 volumio sudo[3561]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 12:12:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 12:12:11 volumio sudo[3558]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: info: Shairport-Sync Started Jul 18 12:12:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 18 12:12:11 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 18 12:12:11 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 18 12:12:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 18 12:12:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 12:12:11 volumio sudo[3561]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: info: Shairport-Sync Started Jul 18 12:12:11 volumio mpd[3550]: Jul 18 12:12 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 18 12:12:11 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 18 12:12:11 volumio systemd[1]: Started Music Player Daemon. Jul 18 12:12:11 volumio sudo[3537]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio sudo[3527]: pam_unix(sudo:session): session closed for user root Jul 18 12:12:11 volumio volumio[940]: error: MPD error: The expression evaluated to a falsy value: Jul 18 12:12:11 volumio volumio[940]: assert.ok(self.idling) Jul 18 12:12:11 volumio volumio[940]: error: The expression evaluated to a falsy value: Jul 18 12:12:11 volumio volumio[940]: assert.ok(self.idling) Jul 18 12:12:11 volumio volumio[940]: error: updateQueue error: null Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 18 12:12:15 volumio volumio[940]: info: CoreStateMachine::getcurrentVolume Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::volumioRetrievevolume Jul 18 12:12:15 volumio volumio[940]: info: VolumeController:: Volume=53 Mute =false Jul 18 12:12:15 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:15 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:15 volumio volumio[940]: info: CoreStateMachine::updateTrackBlock Jul 18 12:12:15 volumio volumio[940]: info: CorePlayQueue::getTrackBlock Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::volumioRetrievevolume Jul 18 12:12:15 volumio volumio[940]: info: VolumeController:: Volume=53 Mute =false Jul 18 12:12:15 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:15 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:15 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 18 12:12:22 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 12:12:43 volumio volumio[940]: info: Preload queue cleared Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::ClearQueue Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::stop Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::clearPlayQueue Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::saveQueue Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushQueue Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::addQueueItems Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::addQueueItems Jul 18 12:12:43 volumio volumio[940]: info: Preload queue cleared Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/郭兰英 - 我的祖国【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/郭兰英 - 我的祖国【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/张也 - 走进新时代【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/张也 - 走进新时代【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/董文华 - 春天的故事【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/董文华 - 春天的故事【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/蒋大为 - 在那桃花盛开的地方【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/蒋大为 - 在那桃花盛开的地方【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/李光羲 - 祝酒歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/李光羲 - 祝酒歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/李谷一 - 妹妹找哥泪花流【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/李谷一 - 妹妹找哥泪花流【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/何纪光 - 挑担茶叶上北京【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/何纪光 - 挑担茶叶上北京【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/关贵敏 - 浪花里飞出欢乐的歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/关贵敏 - 浪花里飞出欢乐的歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/才旦卓玛 - 翻身农奴把歌唱【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/才旦卓玛 - 翻身农奴把歌唱【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/彭丽媛 - 父老乡亲【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/彭丽媛 - 父老乡亲【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/朱明瑛 - 回娘家【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/朱明瑛 - 回娘家【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/尹相杰，于文华 - 纤夫的爱【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/尹相杰，于文华 - 纤夫的爱【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/德德玛 - 美丽的草原我的【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/德德玛 - 美丽的草原我的【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/金曼 - 红梅赞【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/金曼 - 红梅赞【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/臧玉琰 - 牧歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/臧玉琰 - 牧歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/郭颂 - 乌苏里船歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/郭颂 - 乌苏里船歌【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Adding Item to queue: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/朱崇懋 - 草原之夜【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: Using cached record of: music-library/NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/朱崇懋 - 草原之夜【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushQueue Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::saveQueue Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::updateTrackBlock Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrackBlock Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPlay Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::play index 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::stop Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::play index undefined Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::startPlaybackTimer Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::clearAddPlayTracks NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand stop Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand stop took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand clear Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces system playlist update Jul 18 12:12:43 volumio volumio[940]: info: Ignoring MPD Status Update Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand clear took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand add "NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav" Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces system playlist update Jul 18 12:12:43 volumio volumio[940]: info: Ignoring MPD Status Update Jul 18 12:12:43 volumio volumio[940]: error: updateQueue error: null Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces system playlist update Jul 18 12:12:43 volumio volumio[940]: info: Ignoring MPD Status Update Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 1ms Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand add "NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav" took 0 milliseconds Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 0ms Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand play Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces system playlist update Jul 18 12:12:43 volumio volumio[940]: info: Ignoring MPD Status Update Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 1ms Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand play took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 1ms Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand status took 184 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand status took 184 milliseconds Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:43 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState stateService play Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus stop Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 186ms Jul 18 12:12:43 volumio volumio[940]: info: Jul 18 12:12:43 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand status took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:43 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState stateService play Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:12:43 volumio volumio[940]: info: Received an update from plugin. extracting info from payload Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 191ms Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand status took 6 milliseconds Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:43 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState stateService play Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:12:43 volumio volumio[940]: info: Received an update from plugin. extracting info from payload Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 12ms Jul 18 12:12:43 volumio volumio[940]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 18 12:12:43 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:43 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:43 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState stateService play Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:12:43 volumio volumio[940]: info: Received an update from plugin. extracting info from payload Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:43 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:43 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:43 volumio volumio[940]: info: ------------------------------ 17ms Jul 18 12:12:49 volumio volumio[940]: info: VolumeController::SetAlsaVolume18 Jul 18 12:12:49 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:49 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:49 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:49 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:50 volumio volumio[940]: info: VolumeController::SetAlsaVolume40 Jul 18 12:12:51 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:51 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:51 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:51 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::volumioPause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::pause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::stPlaybackTimer Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::servicePause Jul 18 12:12:54 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::servicePause Jul 18 12:12:54 volumio volumio[940]: info: ControllerMpd::pause Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand pause Jul 18 12:12:54 volumio volumio[940]: info: Jul 18 12:12:54 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:54 volumio volumio[940]: info: sendMpdCommand pause took 1 milliseconds Jul 18 12:12:54 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:54 volumio volumio[940]: info: Jul 18 12:12:54 volumio volumio[940]: ---------------------------- MPD announces state update: player Jul 18 12:12:54 volumio volumio[940]: info: ControllerMpd::getState Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:12:54 volumio volumio[940]: info: sendMpdCommand status took 1 milliseconds Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:54 volumio volumio[940]: info: sendMpdCommand status took 0 milliseconds Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::parseState Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:12:54 volumio volumio[940]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:54 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:54 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:54 volumio volumio[940]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":11724,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:54 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::syncState stateService pause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus pause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:54 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::stPlaybackTimer Jul 18 12:12:54 volumio volumio[940]: info: ------------------------------ 4ms Jul 18 12:12:54 volumio volumio[940]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 18 12:12:54 volumio volumio[940]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:12:54 volumio volumio[940]: info: ControllerMpd::pushState Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::servicePushState Jul 18 12:12:54 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:54 volumio volumio[940]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":11724,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"???","album":null,"uri":"NAS/truenas/《19一人一首成名曲》/一人一首成名曲 【大陆版】/一人一首成名曲1（大陆版）HD/王玉珍 - 洪湖水浪打浪【Q群：214696318】.wav","trackType":"wav"} Jul 18 12:12:54 volumio volumio[940]: verbose: CURRENT POSITION 0 Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::syncState stateService pause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::syncState currentStatus pause Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::pushState Jul 18 12:12:54 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:12:54 volumio volumio[940]: info: CoreCommandRouter::volumioPushState Jul 18 12:12:54 volumio volumio[940]: info: CoreStateMachine::stPlaybackTimer Jul 18 12:12:54 volumio volumio[940]: info: ------------------------------ 6ms Jul 18 12:12:56 volumio volumio[940]: info: CoreCommandRouter::volumioGetState Jul 18 12:12:56 volumio volumio[940]: info: CorePlayQueue::getTrack 0 Jul 18 12:13:05 volumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 18 12:13:05 volumio volumio[940]: info: Preload queue cleared Jul 18 12:13:37 volumio volumio[940]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 12:13:37 volumio volumio[940]: Error: connect ETIMEDOUT 128.242.240.61:80 Jul 18 12:13:37 volumio volumio[940]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 18 12:13:37 volumio volumio[940]: errno: -110, Jul 18 12:13:37 volumio volumio[940]: code: 'ETIMEDOUT', Jul 18 12:13:37 volumio volumio[940]: syscall: 'connect', Jul 18 12:13:37 volumio volumio[940]: address: '128.242.240.61', Jul 18 12:13:37 volumio volumio[940]: port: 80 Jul 18 12:13:37 volumio volumio[940]: } Jul 18 12:13:37 volumio volumio[940]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 12:13:38 volumio sudo[3684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-18 12:12 Jul 18 12:13:38 volumio sudo[3684]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"