-- Logs begin at Thu 2019-02-14 18:11:58 HKT, end at Wed 2026-08-26 15:13:56 HKT. -- Aug 26 15:12:00 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 15:12:00 volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 26 15:12:00 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Aug 26 15:12:00 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:00 volumio volumio[1014]: info: CoreCommandRouter::volumioGetQueue Aug 26 15:12:00 volumio volumio[1014]: info: CoreStateMachine::getQueue Aug 26 15:12:00 volumio volumio[1014]: info: CorePlayQueue::getQueue Aug 26 15:12:02 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:02 volumio volumio[1014]: info: CURURI: music-library Aug 26 15:12:02 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:04 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:04 volumio volumio[1014]: info: CURURI: music-library/USB Aug 26 15:12:04 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:04 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::volumioGetBrowseSources Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 15:12:05 volumio volumio-remote-updater[554]: No test mode Aug 26 15:12:05 volumio volumio-remote-updater[554]: No alpha test mode Aug 26 15:12:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 26 15:12:06 volumio volumio[1014]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.912","updateavailable":true} Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 26 15:12:06 volumio volumio[1014]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 26 15:12:06 volumio volumio[1014]: info: Completed starting MyVolumio Plugin Aug 26 15:12:06 volumio volumio[1014]: [Metrics] CommandRouter: 35s 730.95ms Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::volumiosetStartupVolume Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 15:12:06 volumio volumio[1014]: info: VolumeController:: Setting startup Volume 10 Aug 26 15:12:06 volumio volumio[1014]: info: VolumeController::SetAlsaVolume10 Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::Close All Modals sent Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::Close All Modals sent Aug 26 15:12:06 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:06 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:06 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:07 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 26 15:12:07 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 15:12:07 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 26 15:12:11 volumio ntpd[720]: Soliciting pool server 95.111.202.5 Aug 26 15:12:11 volumio ntpd[720]: Soliciting pool server 193.182.111.12 Aug 26 15:12:12 volumio ntpd[720]: Soliciting pool server 108.59.2.24 Aug 26 15:12:12 volumio ntpd[720]: Soliciting pool server 193.182.111.14 Aug 26 15:12:12 volumio ntpd[720]: Soliciting pool server 193.182.111.143 Aug 26 15:12:12 volumio ntpd[720]: Soliciting pool server 139.199.215.251 Aug 26 15:12:13 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:13 volumio volumio[1014]: info: BOOT COMPLETED Aug 26 15:12:13 volumio ntpd[720]: Soliciting pool server 119.28.183.184 Aug 26 15:12:13 volumio ntpd[720]: Soliciting pool server 119.28.206.193 Aug 26 15:12:13 volumio ntpd[720]: Soliciting pool server 162.159.200.1 Aug 26 15:12:14 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:14 volumio volumio[1014]: info: CURURI: music-library/USB/1463-BF9F Aug 26 15:12:14 volumio ntpd[720]: Soliciting pool server 5.79.108.34 Aug 26 15:12:14 volumio ntpd[720]: Soliciting pool server 111.230.189.174 Aug 26 15:12:14 volumio ntpd[720]: Soliciting pool server 162.159.200.123 Aug 26 15:12:14 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:15 volumio ntpd[720]: Soliciting pool server 2001:41d0:305:2100::3f3e Aug 26 15:12:15 volumio ntpd[720]: Soliciting pool server 106.54.244.49 Aug 26 15:12:16 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:16 volumio volumio[1014]: info: CURURI: music-library/USB/1463-BF9F/数播专用试听歌曲 Aug 26 15:12:16 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:17 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::ClearQueue Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::clearPlayQueue Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::saveQueue Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushQueue Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::addQueueItems Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::addQueueItems Aug 26 15:12:17 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:17 volumio volumio[1014]: info: Adding Item to queue: music-library/USB/1463-BF9F/数播专用试听歌曲/DSD Aug 26 15:12:17 volumio volumio[1014]: info: Exploding uri music-library/USB/1463-BF9F/数播专用试听歌曲/DSD in service mpd Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E5%93%81/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%20-%20%E4%BA%B2%E7%88%B1%E7%9A%84%E5%B0%8F%E5%AD%A9.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E5%93%81/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%20-%20%E6%9C%88%E5%8D%8A%E5%BC%AF.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E5%A7%9A%E7%92%8E%E6%A0%BC/%E5%93%81/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%2F%E5%A7%9A%E7%92%8E%E6%A0%BC%20-%20%E7%88%B6%E4%BA%B2%E5%86%99%E7%9A%84%E6%95%A3%E6%96%87%E8%AF%97.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%AD%99%E9%9C%B2%20-%20%E8%8A%B1%E5%BF%83.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=UNAMAS%20Strings%20Quartet/%E7%BB%B4%E7%93%A6%E5%B0%94%E7%AC%AC%EF%BC%9A%E5%9B%9B%E5%AD%A3/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%BC%A6%E4%B9%90%2FConcerto%20in%20E%20major%2CLa%20Primavera%20(Spring)%20%2COp.%208-1%2C%20RV%20269.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=Friedrich%20Wilhelm%20Schnurr/Moonlight%20%E3%80%9CBeethoven%20Anthology%E3%80%9C/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E5%BC%A6%E4%B9%90%2F%E7%AC%AC17%E5%8F%B7%E9%92%A2%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2%E2%80%9D%E6%9A%B4%E9%A3%8E%E9%9B%A8%E2%80%9D%E7%AC%AC%E4%B8%89%E4%B9%90%E7%AB%A0.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/第17号钢琴奏鸣曲”暴风雨”第三乐章.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E6%96%87%E9%9D%99%E5%AE%81%20-%20%E6%83%85%E4%B9%A6.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/文静宁 - 情书.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E7%8E%8B%E8%8F%B2/%E7%8E%8B%E8%8F%B2/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%B5%81%E5%B9%B4.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/王菲 - 流年.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%BA%A2%E8%B1%86.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/王菲 - 红豆.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E7%AB%A5%E4%B8%BD/%E6%B0%B8%E8%BF%9C%E7%9A%84%E7%94%BB%E9%9D%A2/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E4%B8%80%E9%9D%A2%E6%B9%96%E6%B0%B4.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 一面湖水.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 你的眼神.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E6%81%B0%E4%BC%BC%E4%BD%A0%E7%9A%84%E6%B8%A9%E6%9F%94.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 恰似你的温柔.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E6%9C%88%E5%85%89%E5%B0%8F%E5%A4%9C%E6%9B%B2.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 月光小夜曲.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E7%AB%A5%E4%B8%BD/%E8%AF%95%E9%9F%B3%E7%AB%A5%E4%B8%BDDSD/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E6%9C%88%E7%89%99%E6%B3%89.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 月牙泉.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E4%B8%BD%2F%E7%AB%A5%E4%B8%BD%20-%20%E9%80%81%E5%88%AB.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童丽/童丽 - 送别.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E7%AB%A5%E5%AE%89%E6%A0%BC%20-%20%E6%98%8E%E5%A4%A9%E4%BD%A0%E6%98%AF%E5%90%A6%E4%BE%9D%E7%84%B6%E7%88%B1%E6%88%91.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/童安格 - 明天你是否依然爱我.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E4%B8%89%E5%B9%B4.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 三年.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%94%A1%E7%90%B4/%E7%B2%BE%E9%80%89.%E8%94%A1%E7%90%B4%20(Remastered)/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 你的眼神.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%94%A1%E7%90%B4/%E9%81%87%E8%A7%81/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E5%BC%A0%E4%B8%89%E7%9A%84%E6%AD%8C.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 张三的歌.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%94%A1%E7%90%B4/%E7%B2%BE%E9%80%89.%E8%94%A1%E7%90%B4%20(Remastered)/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%81%B0%E4%BC%BC%E4%BD%A0%E7%9A%84%E6%B8%A9%E6%9F%94.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 恰似你的温柔.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%88%91%E6%9C%89%E4%B8%80%E6%AE%B5%E6%83%85.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 我有一段情.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%94%A1%E7%90%B4/%E7%B2%BE%E9%80%89.%E8%94%A1%E7%90%B4%20(Remastered)/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%8A%89%E6%8B%A9.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 抉择.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%9C%80%E5%90%8E%E4%B8%80%E5%A4%9C.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 最后一夜.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%9C%88%E5%85%89%E5%B0%8F%E5%A4%9C%E6%9B%B2.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 月光小夜曲.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E6%9C%BA%E9%81%87.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 机遇.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E7%97%B4%E7%97%B4%E7%9A%84%E7%AD%89.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 痴痴的等.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=CHOI%20KAM/CHOI%20KAM/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E9%9B%A8%E4%B8%AD%E7%9A%84%E5%9F%8E%E5%B8%82.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/蔡琴/蔡琴 - 雨中的城市.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%B0%AD%E8%89%B3%20-%20%E5%8D%97%E5%B1%B1%E5%8D%97.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/谭艳 - 南山南.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%B5%B5%E9%9B%B7%20-%20%E7%94%BB.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/赵雷 - 画.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%B5%B5%E9%B9%8F/%E4%BD%8E%E9%9F%B3%E5%85%B1%E9%B8%A3/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%B5%B5%E9%B9%8F%20-%20%E5%8C%97%E5%9B%BD%E4%B9%8B%E6%98%A5.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E8%B5%B5%E9%B9%8F/%E4%BD%8E%E9%9F%B3%E5%85%B1%E9%B8%A3/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E8%B5%B5%E9%B9%8F%20-%20%E6%99%9A%E7%A7%8B.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 晚秋.dsf Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E4%BD%86%E6%84%BF%E4%BA%BA%E9%95%BF%E4%B9%85.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 但愿人长久.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E5%8F%88%E8%A7%81%E7%82%8A%E7%83%9F.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 又见炊烟.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E5%A4%9C%E6%9D%A5%E9%A6%99.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 夜来香.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E5%B0%8F%E5%9F%8E%E6%95%85%E4%BA%8B.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 小城故事.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E5%B1%B1%E8%8C%B6%E8%8A%B1.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 山茶花.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E6%81%B0%E6%81%B0%E4%BC%BC%E4%BD%A0%E7%9A%84%E6%B8%A9%E6%9F%94.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 恰恰似你的温柔.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E6%9C%88%E4%BA%AE%E4%BB%A3%E8%A1%A8%E6%88%91%E7%9A%84%E5%BF%83.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 月亮代表我的心.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E7%8B%AC%E4%B8%8A%E8%A5%BF%E6%A5%BC.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 独上西楼.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E7%94%9C%E8%9C%9C%E8%9C%9C.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 甜蜜蜜.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%82%93%E4%B8%BD%E5%90%9B%2F%E9%82%93%E4%B8%BD%E5%90%9B%20-%20%E8%83%AD%E8%84%82%E6%B3%AA.dff&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/邓丽君/邓丽君 - 胭脂泪.dff Aug 26 15:12:17 volumio volumio[1014]: info: ALBUMART /albumart?cacheid=487&web=%E9%BE%9A%E7%8E%A5/%E5%BE%AE%E9%A3%8E%E6%8B%82%E9%9D%A2/extralarge&path=%2Fmnt%2FUSB%2F1463-BF9F%2F%E6%95%B0%E6%92%AD%E4%B8%93%E7%94%A8%E8%AF%95%E5%90%AC%E6%AD%8C%E6%9B%B2%2FDSD%2F%E9%BE%9A%E7%8E%A5%20-%20%E6%BD%AE%E6%B9%BF%E7%9A%84%E5%BF%83.dsf&metadata=false Aug 26 15:12:17 volumio volumio[1014]: info: URI /mnt/USB/1463-BF9F/数播专用试听歌曲/DSD/龚玥 - 潮湿的心.dsf Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushQueue Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::saveQueue Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPlay Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::play index 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand stop took 8 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand clear took 2 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf" Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 7ms Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf" took 5 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 4ms Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 4ms Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:17 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 8ms Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand play took 6 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 5ms Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 4ms Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 54 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 52 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 52 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: Aug 26 15:12:17 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 13 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 5 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:17 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:17 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 91ms Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 108ms Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 111ms Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand status took 51 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 47 milliseconds Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 44 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:17 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":165,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:17 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 94ms Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 85ms Aug 26 15:12:17 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 42 milliseconds Aug 26 15:12:17 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:17 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":194,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:17 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:17 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:17 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:17 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:17 volumio volumio[1014]: info: ------------------------------ 111ms Aug 26 15:12:18 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::ClearQueue Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::clearPlayQueue Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::saveQueue Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushQueue Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::addQueueItems Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::addQueueItems Aug 26 15:12:18 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:18 volumio volumio[1014]: info: Adding Item to queue: music-library/USB/1463-BF9F/数播专用试听歌曲/DSD Aug 26 15:12:18 volumio volumio[1014]: info: Using cached record of: music-library/USB/1463-BF9F/数播专用试听歌曲/DSD Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushQueue Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::saveQueue Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPlay Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::play index 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:18 volumio volumio[1014]: info: Aug 26 15:12:18 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand stop took 47 milliseconds Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand stop took 13 milliseconds Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:12:18 volumio volumio[1014]: info: Aug 26 15:12:18 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:18 volumio volumio[1014]: info: Aug 26 15:12:18 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:18 volumio volumio[1014]: info: Aug 26 15:12:18 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:18 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand status took 22 milliseconds Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand clear took 22 milliseconds Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand status took 21 milliseconds Aug 26 15:12:18 volumio volumio[1014]: info: sendMpdCommand status took 19 milliseconds Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf" Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:18 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:18 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:18 volumio volumio[1014]: info: No code Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:18 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:18 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:18 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:18 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:18 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: No code Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 72ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 71ms Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:19 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:19 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:19 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:19 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 61ms Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 59 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf" took 59 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 8ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 7ms Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:12:19 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 88ms Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:19 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:19 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 19ms Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand play took 17 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 16ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 15ms Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 8 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 8 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 7 milliseconds Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: info: Aug 26 15:12:19 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 8 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 4 milliseconds Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:19 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:19 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 41ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 60ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 59ms Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand status took 48 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 43 milliseconds Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:19 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":142,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:19 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 80ms Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 76ms Aug 26 15:12:19 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 26 15:12:19 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:19 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":194,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:19 volumio volumio[1014]: verbose: CURRENT POSITION 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:19 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:19 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:19 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:19 volumio volumio[1014]: info: ------------------------------ 94ms Aug 26 15:12:22 volumio ntpd[720]: receive: Unexpected origin timestamp 0xee391054.dc6f3632 does not match aorg 0000000000.00000000 from server@193.182.111.14 xmt 0xee391056.39d0bd06 Aug 26 15:12:22 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:28 volumio volumio[1014]: info: CoreCommandRouter::volumioNext Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::next Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:28 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:28 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:28 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:28 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:28 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:12:28 volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Aug 26 15:12:28 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:12:28 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:12:28 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand stop took 43 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 13 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand stop took 10 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 8 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 6 milliseconds Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand clear took 5 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf" Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"亲爱的小孩","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 亲爱的小孩.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: No code Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:12:29 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 63ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 56ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 54ms Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 48ms Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf" took 47 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 6ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 5ms Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:29 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 14ms Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand play took 12 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 12ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 11ms Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 13 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 11 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 10 milliseconds Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: Aug 26 15:12:29 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 10 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 8 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand status took 6 milliseconds Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:29 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:29 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 45ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 63ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 63ms Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 42 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 41 milliseconds Aug 26 15:12:29 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 41 milliseconds Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:29 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:29 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月半弯","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 月半弯.dsf","trackType":"dsf"} Aug 26 15:12:29 volumio volumio[1014]: verbose: CURRENT POSITION 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:29 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:29 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:29 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 99ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 95ms Aug 26 15:12:29 volumio volumio[1014]: info: ------------------------------ 94ms Aug 26 15:12:31 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioNext Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::next Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 1 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand stop took 37 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand stop took 2 milliseconds Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 7 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand clear took 6 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 5 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf" Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: No code Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: No code Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 73ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 72ms Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 75ms Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 72 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf" took 72 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 5ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 4ms Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:12:31 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 85ms Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:31 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 16ms Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand play took 14 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 14ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 10ms Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 25 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 25 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 25 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 34ms Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: Aug 26 15:12:31 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand status took 2 milliseconds Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:31 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:31 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:31 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 94ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 93ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 72ms Aug 26 15:12:31 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 65 milliseconds Aug 26 15:12:31 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:31 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"父亲写的散文诗","artist":"姚璎格","album":"品","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/姚璎格/姚璎格 - 父亲写的散文诗.dsf","trackType":"dsf"} Aug 26 15:12:31 volumio volumio[1014]: verbose: CURRENT POSITION 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:31 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:31 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:31 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 97ms Aug 26 15:12:31 volumio volumio[1014]: info: ------------------------------ 96ms Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioNext Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::next Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 2 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand stop took 24 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand stop took 3 milliseconds Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 9 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand clear took 8 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 7 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 6 milliseconds Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf" Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: No code Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: No code Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 61ms Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 61ms Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 63ms Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 60 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf" took 60 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 7ms Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 6ms Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:12:35 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 74ms Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:12:35 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 20ms Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand play took 17 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 12ms Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 11ms Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 14 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 15 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 13 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 12 milliseconds Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: info: Aug 26 15:12:35 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand status took 4 milliseconds Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 花心.dsf","artist":null,"album":null,"uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf","trackType":"dsf"} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 花心.dsf","artist":null,"album":null,"uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf","trackType":"dsf"} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:35 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 花心.dsf","artist":null,"album":null,"uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf","trackType":"dsf"} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:35 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 花心.dsf","artist":null,"album":null,"uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf","trackType":"dsf"} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:35 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 59ms Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 91ms Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 89ms Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 88ms Aug 26 15:12:35 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 73 milliseconds Aug 26 15:12:35 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:12:35 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 花心.dsf","artist":null,"album":null,"uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/孙露 - 花心.dsf","trackType":"dsf"} Aug 26 15:12:35 volumio volumio[1014]: verbose: CURRENT POSITION 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:12:35 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:12:35 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:12:35 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:12:35 volumio volumio[1014]: info: ------------------------------ 94ms Aug 26 15:12:39 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:47 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:12:51 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:51 volumio volumio[1014]: info: CURURI: music-library Aug 26 15:12:51 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:53 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 15:12:53 volumio volumio[1014]: info: CURURI: music-library/INTERNAL Aug 26 15:12:53 volumio volumio[1014]: error: Failed LSINFO: null Aug 26 15:12:53 volumio volumio[1014]: info: Preload queue cleared Aug 26 15:12:56 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:04 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPlay Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::play index 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 3 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand stop took 13 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand stop took 3 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 9 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand clear took 9 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 6 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 4 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf" Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: No code Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService stop Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: No code Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 66ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 66ms Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 68ms Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 65 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf" took 66 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 7ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 6ms Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:13:05 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 84ms Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:05 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 21ms Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand play took 16 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 15ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 14ms Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 23 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 24 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 22 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 33ms Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: Aug 26 15:13:05 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 10 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:05 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:05 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 75ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 74ms Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 44 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 43 milliseconds Aug 26 15:13:05 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 43 milliseconds Aug 26 15:13:05 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:05 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:05 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"低音共鸣","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/赵鹏 - 北国之春.dsf","trackType":"dsf"} Aug 26 15:13:05 volumio volumio[1014]: verbose: CURRENT POSITION 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:05 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:05 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:05 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 124ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 118ms Aug 26 15:13:05 volumio volumio[1014]: info: ------------------------------ 116ms Aug 26 15:13:13 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:13 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 15:13:13 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 15:13:13 volumio volumio[1014]: info: Discovery: Getting this device information Aug 26 15:13:13 volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Aug 26 15:13:13 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:13 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 15:13:21 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPlay Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::play index 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::stop Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::updateTrackBlock Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrackBlock Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::serviceStop Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 29 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::serviceStop Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::stop Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand stop took 23 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::play index undefined Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::startPlaybackTimer Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::clearAddPlayTracks USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand stop took 8 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 7 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 4 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand clear took 5 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf" Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:13:24 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:13:24 volumio volumio[1014]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 21ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 19ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 16ms Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: error: updateQueue error: null Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 17ms Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand add "USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf" took 14 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 8ms Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand play Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces system playlist update Aug 26 15:13:24 volumio volumio[1014]: info: Ignoring MPD Status Update Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 14ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 8ms Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand play took 7 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 7ms Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 6ms Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 85 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 84 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 83 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus stop Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 96ms Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: Aug 26 15:13:24 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 10 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 5 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:24 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:24 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 150ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 147ms Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 53 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 52 milliseconds Aug 26 15:13:24 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 53 milliseconds Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:24 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:24 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:24 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState stateService play Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus play Aug 26 15:13:24 volumio volumio[1014]: info: Received an update from plugin. extracting info from payload Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:24 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:24 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 118ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 112ms Aug 26 15:13:24 volumio volumio[1014]: info: ------------------------------ 111ms Aug 26 15:13:24 volumio volumio[1014]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/UNAMAS%20Strings%20Quartet/%E7%BB%B4%E7%93%A6%E5%B0%94%E7%AC%AC%EF%BC%9A%E5%9B%9B%E5%AD%A3/05c8af52-53b8-4554-9dd0-2480a22dc407.jpg' Aug 26 15:13:24 volumio volumio[1014]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/UNAMAS%20Strings%20Quartet/%E7%BB%B4%E7%93%A6%E5%B0%94%E7%AC%AC%EF%BC%9A%E5%9B%9B%E5%AD%A3/05c8af52-53b8-4554-9dd0-2480a22dc407.jpg' Aug 26 15:13:30 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:32 volumio kernel: sched: RT throttling activated Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::volumioPause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::servicePause Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::servicePause Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::pause Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand pause Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand pause took 9 milliseconds Aug 26 15:13:40 volumio volumio[1014]: info: Aug 26 15:13:40 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:40 volumio volumio[1014]: info: Aug 26 15:13:40 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:40 volumio volumio[1014]: info: Aug 26 15:13:40 volumio volumio[1014]: ---------------------------- MPD announces state update: player Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::getState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand status Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand status took 6 milliseconds Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand status took 4 milliseconds Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand status took 3 milliseconds Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseState Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 15:13:40 volumio volumio[1014]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:40 volumio volumio[1014]: verbose: ControllerMpd::parseTrackInfo Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":15498,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:40 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState stateService pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":15498,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:40 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState stateService pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:40 volumio volumio[1014]: info: ControllerMpd::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::servicePushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":15498,"duration":639,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"Concerto in E major,\"La Primavera\" (Spring) ,Op. 8-1, RV 269","artist":"UNAMAS Strings Quartet","album":"维瓦尔第:四季","uri":"USB/1463-BF9F/数播专用试听歌曲/DSD/弦乐/Concerto in E major,La Primavera (Spring) ,Op. 8-1, RV 269.dsf","trackType":"dsf"} Aug 26 15:13:40 volumio volumio[1014]: verbose: CURRENT POSITION 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState stateService pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::syncState currentStatus pause Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::pushState Aug 26 15:13:40 volumio volumio[1014]: info: CorePlayQueue::getTrack 4 Aug 26 15:13:40 volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Aug 26 15:13:40 volumio volumio[1014]: info: CoreStateMachine::stPlaybackTimer Aug 26 15:13:40 volumio volumio[1014]: info: ------------------------------ 52ms Aug 26 15:13:40 volumio volumio[1014]: info: ------------------------------ 51ms Aug 26 15:13:40 volumio volumio[1014]: info: ------------------------------ 50ms Aug 26 15:13:42 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:51 volumio wpa_supplicant[835]: wlan0: Failed to initiate sched scan Aug 26 15:13:56 volumio volumio[1014]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 15:13:56 volumio volumio[1014]: Error: connect ETIMEDOUT 45.114.11.25:443 Aug 26 15:13:56 volumio volumio[1014]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 26 15:13:56 volumio volumio[1014]: errno: -110, Aug 26 15:13:56 volumio volumio[1014]: code: 'ETIMEDOUT', Aug 26 15:13:56 volumio volumio[1014]: syscall: 'connect', Aug 26 15:13:56 volumio volumio[1014]: address: '45.114.11.25', Aug 26 15:13:56 volumio volumio[1014]: port: 443 Aug 26 15:13:56 volumio volumio[1014]: } Aug 26 15:13:56 volumio volumio[1014]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 15:13:56 volumio sudo[1812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-26 15:12 Aug 26 15:13:56 volumio sudo[1812]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"