-- Logs begin at Sat 2024-11-30 22:37:57 CST, end at Sat 2024-11-30 23:13:20 CST. -- Nov 30 23:12:00 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 23:12:00 volumio volumio[1160]: info: CURURI: artists://%3F%3F%3F Nov 30 23:12:00 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:00 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%20%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%BB%84%E8%8B%B1%E5%8D%8E%20-%20%E6%88%91%E4%B8%8D%E5%85%A5%E5%9C%B0%E7%8B%B1.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E6%9E%97%E7%9F%B3%E5%9F%8E%20-%20%E5%A4%95%E9%98%B3%E7%AE%AB%E9%BC%93.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%AA%86%E7%8E%89%E7%AC%99%20-%20%E5%89%91%E9%98%81%E9%97%BB%E9%93%83.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%AA%86%E7%8E%89%E7%AC%99%20-%20%E4%B8%91%E6%9C%AB%E5%AF%85%E5%88%9D.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%AA%86%E7%8E%89%E7%AC%99%20-%20%E5%AD%90%E6%9C%9F%E5%90%AC%E7%90%B4.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%AA%86%E7%8E%89%E7%AC%99%20-%20%E5%B0%86%E7%9B%B8%E5%92%8C.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:00 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav in service mpd Nov 30 23:12:00 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2F%E9%BC%93%2F%E9%AA%86%E7%8E%89%E7%AC%99%20-%20%E5%8D%A7%E8%96%AA%E5%B0%9D%E8%83%86.wav&metadata=false Nov 30 23:12:00 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:02 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:02 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:02 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:02 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:03 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 23:12:03 volumio volumio[1160]: info: CURURI: artists://%3F%3F%3F/%3F%3F%20%3F%3F%3F%3F%3F%3F Nov 30 23:12:03 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:05 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:05 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:05 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:05 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:05 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:05 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:05 volumio volumio[1160]: info: Adding Item to queue: artists://%3F%3F%3F/%3F%3F%20%3F%3F%3F%3F%3F%3F Nov 30 23:12:05 volumio volumio[1160]: info: Exploding uri artists://%3F%3F%3F/%3F%3F%20%3F%3F%3F%3F%3F%3F in service mpd Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::play index 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:05 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:05 volumio volumio[1160]: info: Nov 30 23:12:05 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand stop took 37 milliseconds Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand stop took 24 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:05 volumio volumio[1160]: info: Nov 30 23:12:05 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:05 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" Nov 30 23:12:05 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:05 volumio volumio[1160]: info: Nov 30 23:12:05 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:05 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:05 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:05 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:05 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:05 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:05 volumio volumio[1160]: info: Nov 30 23:12:05 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand play took 6 milliseconds Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand status took 30 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:05 volumio volumio[1160]: info: Nov 30 23:12:05 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:05 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:05 volumio volumio[1160]: info: ------------------------------ 38ms Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:05 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:05 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:05 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:05 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:05 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:05 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:05 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:05 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:05 volumio volumio[1160]: info: ------------------------------ 10ms Nov 30 23:12:17 volumio volumio[1160]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 30 23:12:17 volumio volumio[1160]: info: CoreCommandRouter::volumioGetState Nov 30 23:12:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:18 volumio volumio[1160]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 30 23:12:18 volumio volumio[1160]: info: Retrying Login Due to Network Error Nov 30 23:12:18 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 23:12:18 volumio volumio[1160]: info: CURURI: artists://%3F%3F%3F/%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F Nov 30 23:12:18 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:20 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:20 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:20 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:20 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::play index 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:20 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:20 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:20 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:20 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:20 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:20 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:20 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:20 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:20 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:20 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:20 volumio volumio[1160]: info: Nov 30 23:12:20 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand stop took 42 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand stop took 24 milliseconds Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:20 volumio volumio[1160]: info: Nov 30 23:12:20 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:20 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav" Nov 30 23:12:20 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:20 volumio volumio[1160]: info: Nov 30 23:12:20 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:20 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:20 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav" took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:20 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:20 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:12:20 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand play took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: Nov 30 23:12:20 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:20 volumio volumio[1160]: info: Nov 30 23:12:20 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1090,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav","trackType":"wav"} Nov 30 23:12:20 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:20 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:12:20 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:20 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:20 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":1090,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav","trackType":"wav"} Nov 30 23:12:20 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:20 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:20 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:20 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:20 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:20 volumio volumio[1160]: info: ------------------------------ 16ms Nov 30 23:12:26 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:26 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:26 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:26 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:12:28 volumio volumio[1160]: info: MyVolumio login type: Token Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::volumioNext Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::next Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:28 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand stop took 35 milliseconds Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:28 volumio volumio[1160]: info: Nov 30 23:12:28 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand stop took 0 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:28 volumio volumio[1160]: info: Nov 30 23:12:28 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:28 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav" Nov 30 23:12:28 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:28 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:28 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:28 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:28 volumio volumio[1160]: info: Nov 30 23:12:28 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:28 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav" took 1 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:28 volumio volumio[1160]: info: ------------------------------ 0ms Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:12:28 volumio volumio[1160]: info: Nov 30 23:12:28 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:28 volumio volumio[1160]: info: Nov 30 23:12:28 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand status took 43 milliseconds Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand status took 3 milliseconds Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":486,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav","trackType":"wav"} Nov 30 23:12:28 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:28 volumio volumio[1160]: info: ------------------------------ 51ms Nov 30 23:12:28 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:28 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:28 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":486,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav","trackType":"wav"} Nov 30 23:12:28 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:28 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:28 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:28 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:28 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:28 volumio volumio[1160]: info: ------------------------------ 27ms Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::volumioNext Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::next Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:31 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand stop took 46 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:31 volumio volumio[1160]: info: Nov 30 23:12:31 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand stop took 5 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:31 volumio volumio[1160]: info: Nov 30 23:12:31 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:31 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand clear took 2 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav" Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:31 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:31 volumio volumio[1160]: info: ------------------------------ 7ms Nov 30 23:12:31 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:31 volumio volumio[1160]: info: Nov 30 23:12:31 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:31 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:31 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav" took 1 milliseconds Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:31 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand play took 0 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: Nov 30 23:12:31 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:31 volumio volumio[1160]: info: Nov 30 23:12:31 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1573,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav","trackType":"wav"} Nov 30 23:12:31 volumio volumio[1160]: verbose: CURRENT POSITION 2 Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:31 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:12:31 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:31 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:31 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":1573,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav","trackType":"wav"} Nov 30 23:12:31 volumio volumio[1160]: verbose: CURRENT POSITION 2 Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:31 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:31 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:31 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:31 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:31 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::volumioNext Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::next Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:35 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand stop took 38 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:35 volumio volumio[1160]: info: Nov 30 23:12:35 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand stop took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:35 volumio volumio[1160]: info: Nov 30 23:12:35 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:35 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 将相和.wav" Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:35 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:35 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:35 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:35 volumio volumio[1160]: info: Nov 30 23:12:35 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:35 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:35 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 将相和.wav" took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:35 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: Nov 30 23:12:35 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:35 volumio volumio[1160]: info: Nov 30 23:12:35 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand status took 34 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 将相和.wav","trackType":"wav"} Nov 30 23:12:35 volumio volumio[1160]: verbose: CURRENT POSITION 3 Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:35 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:12:35 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:35 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:35 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526,"duration":1171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 将相和.wav","trackType":"wav"} Nov 30 23:12:35 volumio volumio[1160]: verbose: CURRENT POSITION 3 Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:35 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:35 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:35 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:35 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:35 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:12:39 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:39 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::play index 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:39 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:39 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:39 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:39 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand stop took 39 milliseconds Nov 30 23:12:39 volumio volumio[1160]: info: Nov 30 23:12:39 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand stop took 28 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:39 volumio volumio[1160]: info: Nov 30 23:12:39 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:39 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" Nov 30 23:12:39 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:39 volumio volumio[1160]: info: Nov 30 23:12:39 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:39 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:39 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" took 0 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:39 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:39 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:39 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:12:39 volumio volumio[1160]: info: Nov 30 23:12:39 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:39 volumio volumio[1160]: info: Nov 30 23:12:39 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand status took 7 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:39 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:39 volumio volumio[1160]: info: ------------------------------ 41ms Nov 30 23:12:39 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:39 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:39 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:39 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:39 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:39 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:39 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:39 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:39 volumio volumio[1160]: info: ------------------------------ 16ms Nov 30 23:12:43 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:43 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::play index 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:43 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:43 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:43 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:43 volumio volumio[1160]: info: Nov 30 23:12:43 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand stop took 39 milliseconds Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand stop took 18 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav" Nov 30 23:12:43 volumio volumio[1160]: info: Nov 30 23:12:43 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:43 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:43 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:43 volumio volumio[1160]: info: ------------------------------ 5ms Nov 30 23:12:43 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:43 volumio volumio[1160]: info: Nov 30 23:12:43 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:43 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav" took 4 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:43 volumio volumio[1160]: info: ------------------------------ 4ms Nov 30 23:12:43 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:12:43 volumio volumio[1160]: info: Nov 30 23:12:43 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:43 volumio volumio[1160]: info: Nov 30 23:12:43 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand status took 39 milliseconds Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":599,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???? ???????????","uri":"USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav","trackType":"wav"} Nov 30 23:12:43 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:43 volumio volumio[1160]: info: ------------------------------ 41ms Nov 30 23:12:43 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:43 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:43 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":599,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???? ???????????","uri":"USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav","trackType":"wav"} Nov 30 23:12:43 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:43 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:43 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:43 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:43 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:43 volumio volumio[1160]: info: ------------------------------ 23ms Nov 30 23:12:55 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:55 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::play index 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:55 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:55 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:55 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:55 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand stop took 49 milliseconds Nov 30 23:12:55 volumio volumio[1160]: info: Nov 30 23:12:55 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand stop took 33 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:55 volumio volumio[1160]: info: Nov 30 23:12:55 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:55 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" Nov 30 23:12:55 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:55 volumio volumio[1160]: info: Nov 30 23:12:55 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:55 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:55 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav" took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:55 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:55 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:12:55 volumio volumio[1160]: info: ------------------------------ 0ms Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: info: Nov 30 23:12:55 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:55 volumio volumio[1160]: info: Nov 30 23:12:55 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:55 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:55 volumio volumio[1160]: info: ------------------------------ 41ms Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand status took 8 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:55 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:55 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:55 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526,"duration":153,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"???","album":"?? ??????","uri":"USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav","trackType":"wav"} Nov 30 23:12:55 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:55 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:55 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:55 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:55 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:55 volumio volumio[1160]: info: ------------------------------ 17ms Nov 30 23:12:56 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:56 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::play index 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:56 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:56 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:56 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:56 volumio volumio[1160]: info: Nov 30 23:12:56 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand stop took 33 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand stop took 16 milliseconds Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:56 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:56 volumio volumio[1160]: info: Nov 30 23:12:56 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:56 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand status took 5 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand clear took 4 milliseconds Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav" Nov 30 23:12:56 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:56 volumio volumio[1160]: info: Nov 30 23:12:56 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:56 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:56 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav" took 1 milliseconds Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:56 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:56 volumio volumio[1160]: info: ------------------------------ 7ms Nov 30 23:12:56 volumio volumio[1160]: info: Nov 30 23:12:56 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:56 volumio volumio[1160]: info: ------------------------------ 4ms Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand play took 4 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:56 volumio volumio[1160]: info: Nov 30 23:12:56 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand status took 26 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":599,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???? ???????????","uri":"USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav","trackType":"wav"} Nov 30 23:12:56 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:56 volumio volumio[1160]: info: ------------------------------ 31ms Nov 30 23:12:56 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:56 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:56 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":599,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???? ???????????","uri":"USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav","trackType":"wav"} Nov 30 23:12:56 volumio volumio[1160]: verbose: CURRENT POSITION 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:56 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:56 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:56 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:56 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:56 volumio volumio[1160]: info: ------------------------------ 13ms Nov 30 23:12:57 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 1 Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:57 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::play index 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:12:57 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:12:57 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:57 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:12:57 volumio volumio[1160]: info: Nov 30 23:12:57 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand stop took 20 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand stop took 3 milliseconds Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:12:57 volumio volumio[1160]: info: Nov 30 23:12:57 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:57 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand status took 13 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand clear took 12 milliseconds Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav" Nov 30 23:12:57 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:12:57 volumio volumio[1160]: info: Nov 30 23:12:57 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:12:57 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:12:57 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav" took 2 milliseconds Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:12:57 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:12:57 volumio volumio[1160]: info: ------------------------------ 15ms Nov 30 23:12:57 volumio volumio[1160]: info: Nov 30 23:12:57 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:57 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand play took 3 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:57 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:12:57 volumio volumio[1160]: info: Nov 30 23:12:57 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand status took 19 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand status took 2 milliseconds Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1090,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav","trackType":"wav"} Nov 30 23:12:57 volumio volumio[1160]: verbose: CURRENT POSITION 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:12:57 volumio volumio[1160]: info: ------------------------------ 22ms Nov 30 23:12:57 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:12:57 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:12:57 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":1090,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav","trackType":"wav"} Nov 30 23:12:57 volumio volumio[1160]: verbose: CURRENT POSITION 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:12:57 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:57 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:12:57 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:12:57 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:12:57 volumio volumio[1160]: info: ------------------------------ 13ms Nov 30 23:12:58 volumio volumio[1160]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 30 23:12:58 volumio volumio[1160]: info: Retrying Login Due to Network Error Nov 30 23:13:01 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 2 Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:01 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::play index 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:01 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:01 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:01 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:01 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:13:01 volumio volumio[1160]: info: Nov 30 23:13:01 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand stop took 41 milliseconds Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand stop took 21 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:13:01 volumio volumio[1160]: info: Nov 30 23:13:01 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:01 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav" Nov 30 23:13:01 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:13:01 volumio volumio[1160]: info: Nov 30 23:13:01 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:01 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:01 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav" took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:13:01 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:13:01 volumio volumio[1160]: info: ------------------------------ 5ms Nov 30 23:13:01 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: info: Nov 30 23:13:01 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand status took 30 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:01 volumio volumio[1160]: info: Nov 30 23:13:01 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":486,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav","trackType":"wav"} Nov 30 23:13:01 volumio volumio[1160]: verbose: CURRENT POSITION 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:13:01 volumio volumio[1160]: info: ------------------------------ 32ms Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:01 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:13:01 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:01 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526,"duration":486,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav","trackType":"wav"} Nov 30 23:13:01 volumio volumio[1160]: verbose: CURRENT POSITION 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:13:01 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:01 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:01 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:01 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:01 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:13:04 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 3 Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:04 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::play index 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:04 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:04 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:04 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:04 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:13:04 volumio volumio[1160]: info: Nov 30 23:13:04 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand stop took 45 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand stop took 26 milliseconds Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:13:04 volumio volumio[1160]: info: Nov 30 23:13:04 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:04 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand status took 2 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand clear took 1 milliseconds Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav" Nov 30 23:13:04 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:13:04 volumio volumio[1160]: info: Nov 30 23:13:04 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:04 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:04 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav" took 2 milliseconds Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:13:04 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:13:04 volumio volumio[1160]: info: ------------------------------ 5ms Nov 30 23:13:04 volumio volumio[1160]: info: Nov 30 23:13:04 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:04 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand play took 2 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:04 volumio volumio[1160]: info: Nov 30 23:13:04 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand status took 32 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1573,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav","trackType":"wav"} Nov 30 23:13:04 volumio volumio[1160]: verbose: CURRENT POSITION 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:13:04 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:13:04 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:04 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:04 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":1573,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav","trackType":"wav"} Nov 30 23:13:04 volumio volumio[1160]: verbose: CURRENT POSITION 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:13:04 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:04 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:04 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:04 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:04 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:13:07 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 4 Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:07 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::play index 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:07 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:07 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:07 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:07 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand stop took 61 milliseconds Nov 30 23:13:07 volumio volumio[1160]: info: Nov 30 23:13:07 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand stop took 43 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:13:07 volumio volumio[1160]: info: Nov 30 23:13:07 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:07 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand clear took 0 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 将相和.wav" Nov 30 23:13:07 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:13:07 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:07 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:13:07 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:13:07 volumio volumio[1160]: info: Nov 30 23:13:07 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:07 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 将相和.wav" took 1 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:13:07 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand play took 0 milliseconds Nov 30 23:13:07 volumio volumio[1160]: info: Nov 30 23:13:07 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:07 volumio volumio[1160]: info: Nov 30 23:13:07 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 将相和.wav","trackType":"wav"} Nov 30 23:13:07 volumio volumio[1160]: verbose: CURRENT POSITION 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:13:07 volumio volumio[1160]: info: ------------------------------ 34ms Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:07 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 23:13:07 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:07 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":1171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 将相和.wav","trackType":"wav"} Nov 30 23:13:07 volumio volumio[1160]: verbose: CURRENT POSITION 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:13:07 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:07 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:07 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:07 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:07 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:13:08 volumio volumio[1160]: info: MyVolumio login type: Token Nov 30 23:13:09 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 5 Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:09 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/黄英华 - 我不入地狱.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/林石城 - 夕阳箫鼓.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 剑阁闻铃.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 丑末寅初.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 子期听琴.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 将相和.wav Nov 30 23:13:09 volumio volumio[1160]: info: Adding Item to queue: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:09 volumio volumio[1160]: info: Using cached record of: music-library/USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::play index 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:09 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:13:09 volumio volumio[1160]: info: Nov 30 23:13:09 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand stop took 53 milliseconds Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand stop took 37 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:13:09 volumio volumio[1160]: info: Nov 30 23:13:09 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:09 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand status took 0 milliseconds Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand clear took 0 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav" Nov 30 23:13:09 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:13:09 volumio volumio[1160]: info: ------------------------------ 3ms Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:09 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:13:09 volumio volumio[1160]: info: ------------------------------ 4ms Nov 30 23:13:09 volumio volumio[1160]: info: Nov 30 23:13:09 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:09 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav" took 2 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:13:09 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:13:09 volumio volumio[1160]: info: Nov 30 23:13:09 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:09 volumio volumio[1160]: info: Nov 30 23:13:09 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand status took 33 milliseconds Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav","trackType":"wav"} Nov 30 23:13:09 volumio volumio[1160]: verbose: CURRENT POSITION 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:13:09 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:13:09 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:09 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:09 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":594,"duration":1292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"???????????????","uri":"USB/5443-25C1/鼓/骆玉笙 - 卧薪尝胆.wav","trackType":"wav"} Nov 30 23:13:09 volumio volumio[1160]: verbose: CURRENT POSITION 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:13:09 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:09 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:09 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:09 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:09 volumio volumio[1160]: info: ------------------------------ 12ms Nov 30 23:13:13 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 23:13:13 volumio volumio[1160]: info: CURURI: artists://Ab%20Und%20Zu Nov 30 23:13:13 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:13 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:13 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/Ab Und Zu - The Void.mp3 Nov 30 23:13:13 volumio volumio[1160]: info: Preloading song: music-library/USB/5443-25C1/TAS The Absolute Sound 1996~2013/Ab Und Zu - A Sad Little Waltz.mp3 Nov 30 23:13:14 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/Ab Und Zu - The Void.mp3 in service mpd Nov 30 23:13:14 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=Ab%20Und%20Zu/Female%20Audiophile/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2FAb%20Und%20Zu%20-%20The%20Void.mp3&metadata=false Nov 30 23:13:14 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/Ab Und Zu - The Void.mp3 Nov 30 23:13:14 volumio volumio[1160]: info: Exploding uri music-library/USB/5443-25C1/TAS The Absolute Sound 1996~2013/Ab Und Zu - A Sad Little Waltz.mp3 in service mpd Nov 30 23:13:14 volumio volumio[1160]: info: ALBUMART /albumart?cacheid=568&web=Ab%20Und%20Zu/TAS%3A%20The%20Absolute%20Sound%202008/extralarge&path=%2Fmnt%2FUSB%2F5443-25C1%2FTAS%20The%20Absolute%20Sound%201996~2013%2FAb%20Und%20Zu%20-%20A%20Sad%20Little%20Waltz.mp3&metadata=false Nov 30 23:13:14 volumio volumio[1160]: info: URI /mnt/USB/5443-25C1/TAS The Absolute Sound 1996~2013/Ab Und Zu - A Sad Little Waltz.mp3 Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 23:13:15 volumio volumio[1160]: info: CURURI: artists://Ab%20Und%20Zu/Female%20Audiophile Nov 30 23:13:15 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:15 volumio volumio[1160]: info: No valid Plugin REST Endpoint Nov 30 23:13:17 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::ClearQueue Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::stPlaybackTimer Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::serviceStop Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 6 Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::serviceStop Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::stop Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::clearPlayQueue Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::addQueueItems Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::addQueueItems Nov 30 23:13:17 volumio volumio[1160]: info: Preload queue cleared Nov 30 23:13:17 volumio volumio[1160]: info: Adding Item to queue: artists://Ab%20Und%20Zu/Female%20Audiophile Nov 30 23:13:17 volumio volumio[1160]: info: Exploding uri artists://Ab%20Und%20Zu/Female%20Audiophile in service mpd Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPushQueue Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::saveQueue Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrackBlock Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPlay Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::play index 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::stop Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::play index undefined Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::startPlaybackTimer Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks USB/5443-25C1/Ab Und Zu - The Void.mp3 Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 23:13:17 volumio volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand stop took 38 milliseconds Nov 30 23:13:17 volumio volumio[1160]: info: Nov 30 23:13:17 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand stop took 23 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 23:13:17 volumio volumio[1160]: info: Nov 30 23:13:17 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:17 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand clear took 0 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "USB/5443-25C1/Ab Und Zu - The Void.mp3" Nov 30 23:13:17 volumio volumio[1160]: error: updateQueue error: null Nov 30 23:13:17 volumio volumio[1160]: info: ------------------------------ 0ms Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:17 volumio volumio[1160]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 30 23:13:17 volumio volumio[1160]: info: ------------------------------ 2ms Nov 30 23:13:17 volumio volumio[1160]: info: Nov 30 23:13:17 volumio volumio[1160]: ---------------------------- MPD announces system playlist update Nov 30 23:13:17 volumio volumio[1160]: info: Ignoring MPD Status Update Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand add "USB/5443-25C1/Ab Und Zu - The Void.mp3" took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Nov 30 23:13:17 volumio volumio[1160]: info: ------------------------------ 1ms Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand play took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: info: Nov 30 23:13:17 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand status took 32 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:17 volumio volumio[1160]: info: Nov 30 23:13:17 volumio volumio[1160]: ---------------------------- MPD announces state update: player Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::getState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand status took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseState Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":176,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Void","artist":"Ab Und Zu","album":"Female Audiophile","uri":"USB/5443-25C1/Ab Und Zu - The Void.mp3","trackType":"mp3"} Nov 30 23:13:17 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Nov 30 23:13:17 volumio volumio[1160]: info: ------------------------------ 35ms Nov 30 23:13:17 volumio volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 23:13:17 volumio volumio[1160]: verbose: ControllerMpd::parseTrackInfo Nov 30 23:13:17 volumio volumio[1160]: info: ControllerMpd::pushState Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::servicePushState Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":605,"duration":176,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Void","artist":"Ab Und Zu","album":"Female Audiophile","uri":"USB/5443-25C1/Ab Und Zu - The Void.mp3","trackType":"mp3"} Nov 30 23:13:17 volumio volumio[1160]: verbose: CURRENT POSITION 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::syncState stateService play Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::syncState currentStatus play Nov 30 23:13:17 volumio volumio[1160]: info: Received an update from plugin. extracting info from payload Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:17 volumio volumio[1160]: info: CoreStateMachine::pushState Nov 30 23:13:17 volumio volumio[1160]: info: CorePlayQueue::getTrack 0 Nov 30 23:13:17 volumio volumio[1160]: info: CoreCommandRouter::volumioPushState Nov 30 23:13:17 volumio volumio[1160]: info: ------------------------------ 11ms Nov 30 23:13:20 volumio volumio[1160]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 23:13:20 volumio volumio[1160]: Error: connect ETIMEDOUT 66.220.146.94:80 Nov 30 23:13:20 volumio volumio[1160]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 30 23:13:20 volumio volumio[1160]: errno: -110, Nov 30 23:13:20 volumio volumio[1160]: code: 'ETIMEDOUT', Nov 30 23:13:20 volumio volumio[1160]: syscall: 'connect', Nov 30 23:13:20 volumio volumio[1160]: address: '66.220.146.94', Nov 30 23:13:20 volumio volumio[1160]: port: 80 Nov 30 23:13:20 volumio volumio[1160]: } Nov 30 23:13:20 volumio volumio[1160]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 23:13:20 volumio sudo[11435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 23:12 Nov 30 23:13:20 volumio sudo[11435]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"