-- Logs begin at Sat 2024-08-31 00:39:13 CST, end at Mon 2024-09-09 00:11:38 CST. -- Sep 09 00:10:06 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:06 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:06 volumio volumio[2947]: info: Listing playlists Sep 09 00:10:16 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:16 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:18 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 00:10:18 volumio volumio[2947]: info: CURURI: music-library/INTERNAL/music_mp3/齐秦 Sep 09 00:10:18 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:18 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 in service mpd Sep 09 00:10:18 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=%C3%86%C3%AB%C3%87%C3%98//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BD%90%E7%A7%A6%2F%E4%B8%8D%E8%AE%A9%E6%88%91%E7%9A%84%E7%9C%BC%E6%B3%AA%E9%99%AA%E6%88%91%E8%BF%87%E5%A4%9C.mp3&metadata=false Sep 09 00:10:18 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 in service mpd Sep 09 00:10:18 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=%C3%86%C3%AB%C3%87%C3%98//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BD%90%E7%A7%A6%2F%E5%A4%96%E9%9D%A2%E7%9A%84%E4%B8%96%E7%95%8C%E5%BE%88%E7%B2%BE%E5%BD%A9.mp3&metadata=false Sep 09 00:10:18 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 in service mpd Sep 09 00:10:18 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=%C3%86%C3%AB%C3%87%C3%98//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BD%90%E7%A7%A6%2F%E5%A4%A7%E7%BA%A6%E5%9C%A8%E5%86%AC%E5%AD%A3.mp3&metadata=false Sep 09 00:10:18 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 in service mpd Sep 09 00:10:18 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=%C3%86%C3%AB%C3%87%C3%98//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BD%90%E7%A7%A6%2F%E6%88%91%E6%98%AF%E4%B8%80%E5%8C%B9%E6%9D%A5%E8%87%AA%E5%8C%97%E6%96%B9%E7%9A%84%E7%8B%BC.mp3&metadata=false Sep 09 00:10:18 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:18 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 in service mpd Sep 09 00:10:18 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=%C3%86%C3%AB%C3%87%C3%98//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BD%90%E7%A7%A6%2F%E6%97%A0%E6%83%85%E7%9A%84%E9%9B%A8%E6%97%A0%E6%83%85%E7%9A%84%E4%BD%A0.mp3&metadata=false Sep 09 00:10:18 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:10:20 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:20 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::play index 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand stop took 19 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand clear took 3 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3" Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: No code Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 27ms Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 30 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 29ms Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 28 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3" took 28 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 4ms Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: No code Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 53ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 57ms Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:20 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 35ms Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand play took 33 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 9ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 8ms Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 8 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 12 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 11 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:20 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 33ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 38ms Sep 09 00:10:20 volumio volumio[2947]: info: Sep 09 00:10:20 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 30 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 30 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 29 milliseconds Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:20 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:20 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:20 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 85ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 85ms Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 78ms Sep 09 00:10:20 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 50 milliseconds Sep 09 00:10:20 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:20 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"²»ÈÃÎÒµÄÑÛÀáÅãÎÒ¹ýÒ¹","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3","trackType":"mp3"} Sep 09 00:10:20 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:20 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:20 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:20 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:20 volumio volumio[2947]: info: ------------------------------ 68ms Sep 09 00:10:25 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:10:25 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:25 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::play index 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand stop took 19 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand clear took 3 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3" Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: No code Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 24ms Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 25 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 25ms Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3" took 24 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 5ms Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 4ms Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: No code Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 48ms Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 50ms Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:25 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 33ms Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand play took 29 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 10ms Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 9ms Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 1 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 12ms Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: Sep 09 00:10:25 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:25 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:25 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:25 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 65ms Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 65ms Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 64ms Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand status took 54 milliseconds Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 52 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":808,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:25 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 71ms Sep 09 00:10:25 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 49 milliseconds Sep 09 00:10:25 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:25 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":316,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÍâÃæµÄÊÀ½çºÜ¾«²Ê","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3","trackType":"mp3"} Sep 09 00:10:25 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:25 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:25 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:25 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:25 volumio volumio[2947]: info: ------------------------------ 117ms Sep 09 00:10:26 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:26 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:26 volumio volumio[2947]: info: Listing playlists Sep 09 00:10:36 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:46 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:46 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:46 volumio volumio[2947]: info: Listing playlists Sep 09 00:10:56 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:10:56 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:58 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:10:58 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:10:58 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::play index 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand stop took 34 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand clear took 3 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/齐秦/大约在冬季.mp3" Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: No code Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 22ms Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 24 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 24ms Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/齐秦/大约在冬季.mp3" took 22 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 4ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: No code Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 43ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 45ms Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:10:58 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 30ms Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand play took 28 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 10ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 7ms Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: Sep 09 00:10:58 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 7 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 5 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:58 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 22ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 29ms Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 09 00:10:58 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:58 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:58 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:58 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:58 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":546,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"´óÔ¼ÔÚ¶¬¼¾","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/大约在冬季.mp3","trackType":"mp3"} Sep 09 00:10:58 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:10:58 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:10:58 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:10:58 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 80ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 79ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 78ms Sep 09 00:10:58 volumio volumio[2947]: info: ------------------------------ 77ms Sep 09 00:11:01 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:11:01 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:01 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::play index 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand stop took 29 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand clear took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3" Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 5 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 6ms Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3" took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: No code Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: No code Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 47ms Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 47ms Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 50ms Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 46ms Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand play took 44 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:01 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 10 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 11 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 10ms Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 8 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 7ms Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:01 volumio volumio[2947]: info: Sep 09 00:11:01 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand status took 1 milliseconds Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:01 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:01 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 32ms Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 46ms Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 44ms Sep 09 00:11:01 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 31 milliseconds Sep 09 00:11:01 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:01 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:01 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:01 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:01 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:01 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:01 volumio volumio[2947]: info: ------------------------------ 49ms Sep 09 00:11:06 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:11:06 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:06 volumio volumio[2947]: info: Listing playlists Sep 09 00:11:16 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:11:16 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:11:22 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:22 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/不让我的眼泪陪我过夜.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/外面的世界很精彩.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/大约在冬季.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/齐秦/无情的雨无情的你.mp3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::play index 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3 Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand stop took 22 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand stop took 4 milliseconds Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand clear took 2 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3" Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: No code Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 22ms Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 24 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 23ms Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3" took 21 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: No code Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 47ms Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 50ms Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:22 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 33ms Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand play took 31 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 9ms Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 9ms Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: Sep 09 00:11:22 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:22 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:22 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:22 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":327,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ÎÒÊÇһƥÀ´×Ô±±·½µÄÀÇ","artist":"ÆëÇØ","album":null,"uri":"INTERNAL/music_mp3/齐秦/我是一匹来自北方的狼.mp3","trackType":"mp3"} Sep 09 00:11:22 volumio volumio[2947]: verbose: CURRENT POSITION 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:22 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:22 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:22 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 35ms Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 61ms Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 60ms Sep 09 00:11:22 volumio volumio[2947]: info: ------------------------------ 59ms Sep 09 00:11:26 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:11:26 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:26 volumio volumio[2947]: info: Listing playlists Sep 09 00:11:27 volumio systemd[1]: Starting Cleanup of Temporary Directories... Sep 09 00:11:28 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Sep 09 00:11:28 volumio systemd[1]: Started Cleanup of Temporary Directories. Sep 09 00:11:30 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 00:11:30 volumio volumio[2947]: info: CURURI: music-library/INTERNAL/music_mp3/黑豹 Sep 09 00:11:30 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:30 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Preloading song: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 in service mpd Sep 09 00:11:30 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=42//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BB%91%E8%B1%B9%2F42_1359_8554.mp3&metadata=false Sep 09 00:11:30 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 in service mpd Sep 09 00:11:30 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=42//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BB%91%E8%B1%B9%2F42_1359_8556.mp3&metadata=false Sep 09 00:11:30 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 in service mpd Sep 09 00:11:30 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=42//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BB%91%E8%B1%B9%2F42_1359_8557.mp3&metadata=false Sep 09 00:11:30 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 in service mpd Sep 09 00:11:30 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=42//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BB%91%E8%B1%B9%2F42_1359_8558.mp3&metadata=false Sep 09 00:11:30 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:30 volumio volumio[2947]: info: Exploding uri music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 in service mpd Sep 09 00:11:30 volumio volumio[2947]: info: ALBUMART /albumart?cacheid=642&web=42//medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2F%E9%BB%91%E8%B1%B9%2F42_1359_8559.mp3&metadata=false Sep 09 00:11:30 volumio volumio[2947]: info: URI /mnt/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 3 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:11:32 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:32 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::play index 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand stop took 16 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand clear took 2 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8554.mp3" Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: No code Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: No code Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 40ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 39ms Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 42ms Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 41 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8554.mp3" took 41 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:11:32 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 47ms Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:32 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 9ms Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand play took 8 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 7ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 6ms Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: Sep 09 00:11:32 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:32 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:32 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 29ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 43ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 42ms Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 33 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 09 00:11:32 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:32 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:32 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:32 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8554","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8554.mp3","trackType":"mp3"} Sep 09 00:11:32 volumio volumio[2947]: verbose: CURRENT POSITION 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:32 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:32 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:32 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 80ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 78ms Sep 09 00:11:32 volumio volumio[2947]: info: ------------------------------ 77ms Sep 09 00:11:34 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 0 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:11:34 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:34 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::play index 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand stop took 18 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand stop took 3 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand clear took 3 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8556.mp3" Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: No code Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 22ms Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 23 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 23ms Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8556.mp3" took 23 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 3ms Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: No code Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 45ms Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 48ms Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:34 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 29ms Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand play took 27 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 7ms Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 6ms Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 3 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: Sep 09 00:11:34 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 5 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:34 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:34 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 24ms Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 43ms Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 42ms Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand status took 38 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 33 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:34 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:34 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 71ms Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 68ms Sep 09 00:11:34 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 35 milliseconds Sep 09 00:11:34 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:34 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":250,"duration":285,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"1359_8556","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8556.mp3","trackType":"mp3"} Sep 09 00:11:34 volumio volumio[2947]: verbose: CURRENT POSITION 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:34 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:34 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:34 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:34 volumio volumio[2947]: info: ------------------------------ 93ms Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioGetState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:36 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::ClearQueue Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::stPlaybackTimer Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::serviceStop Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 1 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::serviceStop Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::stop Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::clearPlayQueue Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::addQueueItems Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::addQueueItems Sep 09 00:11:36 volumio volumio[2947]: info: Preload queue cleared Sep 09 00:11:36 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8554.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8556.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8558.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: Using cached record of: music-library/INTERNAL/music_mp3/黑豹/42_1359_8559.mp3 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushQueue Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::saveQueue Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::updateTrackBlock Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrackBlock Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPlay Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::play index 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::play index undefined Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::startPlaybackTimer Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/黑豹/42_1359_8557.mp3 Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand stop took 49 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand stop took 8 milliseconds Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 8 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand clear took 8 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 5 milliseconds Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8557.mp3" Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: No code Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: No code Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 68ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 67ms Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: error: updateQueue error: null Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 69ms Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 67 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand add "INTERNAL/music_mp3/黑豹/42_1359_8557.mp3" took 66 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 5ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 4ms Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand play Sep 09 00:11:36 volumio volumio[2947]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 81ms Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces system playlist update Sep 09 00:11:36 volumio volumio[2947]: info: Ignoring MPD Status Update Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 18ms Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand play took 16 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 15ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 14ms Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 6 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 4 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus stop Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 14ms Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: Sep 09 00:11:36 volumio volumio[2947]: ---------------------------- MPD announces state update: player Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::getState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand status Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 2 milliseconds Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand status took 1 milliseconds Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseState Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:36 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:36 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:36 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 57ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 57ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 55ms Sep 09 00:11:36 volumio volumio[2947]: info: sendMpdCommand playlistinfo took 46 milliseconds Sep 09 00:11:36 volumio volumio[2947]: verbose: ControllerMpd::parseTrackInfo Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:36 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ControllerMpd::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::servicePushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":286,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"1359_8557","artist":"42","album":null,"uri":"INTERNAL/music_mp3/黑豹/42_1359_8557.mp3","trackType":"mp3"} Sep 09 00:11:36 volumio volumio[2947]: verbose: CURRENT POSITION 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState stateService play Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::syncState currentStatus play Sep 09 00:11:36 volumio volumio[2947]: info: Received an update from plugin. extracting info from payload Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: CoreStateMachine::pushState Sep 09 00:11:36 volumio volumio[2947]: info: CorePlayQueue::getTrack 2 Sep 09 00:11:36 volumio volumio[2947]: info: CoreCommandRouter::volumioPushState Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 74ms Sep 09 00:11:36 volumio volumio[2947]: info: ------------------------------ 73ms Sep 09 00:11:38 volumio volumio[2947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 00:11:38 volumio volumio[2947]: Error: connect ECONNREFUSED 162.125.80.5:80 Sep 09 00:11:38 volumio volumio[2947]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 09 00:11:38 volumio volumio[2947]: errno: -111, Sep 09 00:11:38 volumio volumio[2947]: code: 'ECONNREFUSED', Sep 09 00:11:38 volumio volumio[2947]: syscall: 'connect', Sep 09 00:11:38 volumio volumio[2947]: address: '162.125.80.5', Sep 09 00:11:38 volumio volumio[2947]: port: 80 Sep 09 00:11:38 volumio volumio[2947]: } Sep 09 00:11:38 volumio volumio[2947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 00:11:38 volumio sudo[3852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-09 00:10 Sep 09 00:11:38 volumio sudo[3852]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"