-- Logs begin at Tue 2026-03-24 15:13:12 CST, end at Tue 2026-03-24 15:57:20 CST. --
Mar 24 15:56:00 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::ClearQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::serviceStop
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::serviceStop
Mar 24 15:56:00 volumio volumio[1069]: info: ControllerMpd::stop
Mar 24 15:56:00 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::clearPlayQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::addQueueItems
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::addQueueItems
Mar 24 15:56:00 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:00 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:00 volumio volumio[1069]: info: CoreCommandRouter::volumioPlay
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::play index 5
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::play index undefined
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:00 volumio volumio[1069]: info: CoreStateMachine::startPlaybackTimer
Mar 24 15:56:00 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::clearAddPlayTracks USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand stop took 59 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand stop took 18 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand clear
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 21 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand clear took 16 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 15 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 14 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand add "USB/____/阿锋 - 低音炮/06. 兰花草.wav"
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: 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}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: No code
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: 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}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: No code
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 91ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 92ms
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: error: updateQueue error: null
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 107 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 114ms
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 111 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand add "USB/____/阿锋 - 低音炮/06. 兰花草.wav" took 112 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 28ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 27ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 25ms
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand play
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: 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}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: No code
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 198ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 210ms
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:01 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 175ms
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand play took 159 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 90ms
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 89ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 88ms
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info:
Mar 24 15:56:01 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 19 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 19 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 14 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand status took 14 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:01 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/06. 兰花草.wav","trackType":"wav"}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/06. 兰花草.wav","trackType":"wav"}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:01 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/06. 兰花草.wav","trackType":"wav"}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:01 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/06. 兰花草.wav","trackType":"wav"}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:01 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/06. 兰花草.wav","trackType":"wav"}
Mar 24 15:56:01 volumio volumio[1069]: verbose: CURRENT POSITION 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:01 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:01 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:01 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 126ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 157ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 151ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 148ms
Mar 24 15:56:01 volumio volumio[1069]: info: ------------------------------ 144ms
Mar 24 15:56:07 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::ClearQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::serviceStop
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 5
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::serviceStop
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::stop
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::clearPlayQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::addQueueItems
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::addQueueItems
Mar 24 15:56:07 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:07 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPlay
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::play index 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::play index undefined
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::startPlaybackTimer
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::clearAddPlayTracks USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand stop took 47 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand stop took 12 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand clear
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 25 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand clear took 23 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 17 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 10 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 7 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand add "USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav"
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: 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}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: No code
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: 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}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: No code
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: 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}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: No code
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 135ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 127ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 123ms
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: error: updateQueue error: null
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 133ms
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 130 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand add "USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav" took 130 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 15ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 13ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 12ms
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand play
Mar 24 15:56:07 volumio volumio[1069]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 166ms
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:07 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 114ms
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand play took 107 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 103ms
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 105ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 96ms
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 47 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 50 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 40 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 38 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 32 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info:
Mar 24 15:56:07 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 34 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 34 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 27 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 20 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 19 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand status took 12 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 227ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 273ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 264ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 256ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 253ms
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 164 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 162 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 161 milliseconds
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav","trackType":"wav"}
Mar 24 15:56:07 volumio volumio[1069]: verbose: CURRENT POSITION 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:07 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:07 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:07 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 325ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 325ms
Mar 24 15:56:07 volumio volumio[1069]: info: ------------------------------ 323ms
Mar 24 15:56:07 volumio volumio[1069]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 24 15:56:07 volumio volumio[1069]: info: Retrying Login Due to Network Error
Mar 24 15:56:17 volumio volumio[1069]: info: MyVolumio login type: Token
Mar 24 15:56:32 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::ClearQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::serviceStop
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 4
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::serviceStop
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::stop
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::clearPlayQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::addQueueItems
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::addQueueItems
Mar 24 15:56:32 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:32 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPlay
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::play index 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::play index undefined
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::startPlaybackTimer
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::clearAddPlayTracks USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:32 volumio volumio[1069]: info:
Mar 24 15:56:32 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand stop took 69 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand stop took 22 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand clear
Mar 24 15:56:32 volumio volumio[1069]: info:
Mar 24 15:56:32 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:32 volumio volumio[1069]: info:
Mar 24 15:56:32 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:32 volumio volumio[1069]: info:
Mar 24 15:56:32 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:32 volumio volumio[1069]: info:
Mar 24 15:56:32 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:32 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand status took 27 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand clear took 24 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand status took 22 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand status took 20 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: info: sendMpdCommand status took 13 milliseconds
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand add "USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav"
Mar 24 15:56:32 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: 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}
Mar 24 15:56:32 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: No code
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: 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}
Mar 24 15:56:32 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: No code
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: 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}
Mar 24 15:56:32 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:32 volumio volumio[1069]: info: No code
Mar 24 15:56:32 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:32 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:32 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 125ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 128ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 126ms
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: error: updateQueue error: null
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 137ms
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 135 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand add "USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav" took 137 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 34ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 24ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 19ms
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand play
Mar 24 15:56:33 volumio volumio[1069]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 182ms
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:33 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 132ms
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand play took 121 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 82ms
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 78ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 71ms
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:33 volumio volumio[1069]: info:
Mar 24 15:56:33 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand status took 88 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand status took 87 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand status took 73 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand status took 58 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand status took 49 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 39 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 40 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 42 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 37 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 36 milliseconds
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:33 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav","trackType":"wav"}
Mar 24 15:56:33 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav","trackType":"wav"}
Mar 24 15:56:33 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:33 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav","trackType":"wav"}
Mar 24 15:56:33 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:33 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav","trackType":"wav"}
Mar 24 15:56:33 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:33 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav","trackType":"wav"}
Mar 24 15:56:33 volumio volumio[1069]: verbose: CURRENT POSITION 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:33 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:33 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:33 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 295ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 337ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 325ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 314ms
Mar 24 15:56:33 volumio volumio[1069]: info: ------------------------------ 302ms
Mar 24 15:56:38 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::ClearQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::serviceStop
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 0
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::serviceStop
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::stop
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::clearPlayQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::addQueueItems
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::addQueueItems
Mar 24 15:56:38 volumio volumio[1069]: info: Preload queue cleared
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/01. 三月里的小雨.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/02. 垄上行.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/03. 读你.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/04. 滚滚红尘.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/05. 美酒加咖啡.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/06. 兰花草.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/07. 一剪梅.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/08. 走过咖啡屋.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/09. 蜗牛与黄鹂鸟.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/10. 一帘幽梦.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/11. 又见炊烟.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Adding Item to queue: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:38 volumio volumio[1069]: info: Using cached record of: music-library/USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::saveQueue
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPlay
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::play index 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::play index undefined
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::startPlaybackTimer
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::clearAddPlayTracks USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand stop
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand stop took 59 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand stop took 17 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand clear
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 22 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand clear took 19 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 16 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 12 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 8 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand add "USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav"
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: 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}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: No code
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: 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}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: No code
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: 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}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: No code
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 117ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 115ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 114ms
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: error: updateQueue error: null
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 131ms
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 125 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand add "USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav" took 125 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 17ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 16ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 13ms
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand play
Mar 24 15:56:38 volumio volumio[1069]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 164ms
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces system playlist update
Mar 24 15:56:38 volumio volumio[1069]: info: Ignoring MPD Status Update
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 61ms
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand play took 54 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 43ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 40ms
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 38ms
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 44 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 34 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 32 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 30 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info:
Mar 24 15:56:38 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 32 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 37 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 39 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 30 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 28 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: info: sendMpdCommand status took 16 milliseconds
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:38 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus stop
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:38 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:38 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:38 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:38 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:38 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:38 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:38 volumio volumio[1069]: info: ------------------------------ 196ms
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 278ms
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 278ms
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 276ms
Mar 24 15:56:39 volumio volumio[1069]: info: sendMpdCommand status took 256 milliseconds
Mar 24 15:56:39 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 247 milliseconds
Mar 24 15:56:39 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 245 milliseconds
Mar 24 15:56:39 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 244 milliseconds
Mar 24 15:56:39 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:56:39 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:56:39 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:39 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:39 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:39 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:39 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:39 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:39 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:39 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 421ms
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 406ms
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 406ms
Mar 24 15:56:39 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 256 milliseconds
Mar 24 15:56:39 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:56:39 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:56:39 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState stateService play
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus play
Mar 24 15:56:39 volumio volumio[1069]: info: Received an update from plugin. extracting info from payload
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:56:39 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:56:39 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:56:39 volumio volumio[1069]: info: ------------------------------ 571ms
Mar 24 15:56:47 volumio volumio[1069]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 24 15:56:47 volumio volumio[1069]: info: Retrying Login Due to Network Error
Mar 24 15:56:57 volumio volumio[1069]: info: MyVolumio login type: Token
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Mar 24 15:57:08 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 24 15:57:18 volumio volumio[1069]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Mar 24 15:57:18 volumio volumio[1069]: info: Preparing to save Alsa Options, stopping services first
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::volumioGetState
Mar 24 15:57:18 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::volumioPause
Mar 24 15:57:18 volumio volumio[1069]: info: CoreStateMachine::pause
Mar 24 15:57:18 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:57:18 volumio volumio[1069]: info: CoreStateMachine::servicePause
Mar 24 15:57:18 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::servicePause
Mar 24 15:57:18 volumio volumio[1069]: info: ControllerMpd::pause
Mar 24 15:57:18 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand pause
Mar 24 15:57:18 volumio volumio[1069]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"USB AUDIO DAC"}}
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 15:57:18 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 15:57:18 volumio volumio[1069]: info: Setting default mixerSoftMaster for Softvolume device
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Mar 24 15:57:19 volumio volumio[1069]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Mar 24 15:57:19 volumio volumio[1069]: info: Disabling external Volume Control
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 24 15:57:19 volumio volumio[1069]: info: Enable softmixer device for audio device undefined
Mar 24 15:57:19 volumio volumio[1069]: info:
Mar 24 15:57:19 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand pause took 398 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:57:19 volumio volumio[1069]: info:
Mar 24 15:57:19 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:57:19 volumio volumio[1069]: info:
Mar 24 15:57:19 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:57:19 volumio volumio[1069]: info:
Mar 24 15:57:19 volumio volumio[1069]: ---------------------------- MPD announces state update: player
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::getState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand status
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand status took 19 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand status took 17 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand status took 12 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand status took 8 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseState
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 24 15:57:19 volumio volumio[1069]: info: Software Volume ALSA configuration written
Mar 24 15:57:19 volumio volumio[1069]: info: Preparing to generate the ALSA configuration file
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 28 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 26 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: info: sendMpdCommand playlistinfo took 24 milliseconds
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:57:19 volumio volumio[1069]: verbose: ControllerMpd::parseTrackInfo
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41116,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:57:19 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState stateService pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41116,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:57:19 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState stateService pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41116,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:57:19 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState stateService pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:57:19 volumio volumio[1069]: info: ControllerMpd::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::servicePushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41116,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????","artist":"??","album":"??? DSD","uri":"USB/____/阿锋 - 低音炮/12. 梅兰梅兰我爱你.wav","trackType":"wav"}
Mar 24 15:57:19 volumio volumio[1069]: verbose: CURRENT POSITION 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState stateService pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::syncState currentStatus pause
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::pushState
Mar 24 15:57:19 volumio volumio[1069]: info: CorePlayQueue::getTrack 11
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState
Mar 24 15:57:19 volumio volumio[1069]: info: CoreStateMachine::stPlaybackTimer
Mar 24 15:57:19 volumio volumio[1069]: info: ------------------------------ 86ms
Mar 24 15:57:19 volumio volumio[1069]: info: ------------------------------ 85ms
Mar 24 15:57:19 volumio volumio[1069]: info: ------------------------------ 83ms
Mar 24 15:57:19 volumio volumio[1069]: info: ------------------------------ 76ms
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Mar 24 15:57:19 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 24 15:57:19 volumio volumio[1069]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Mar 24 15:57:19 volumio volumio[1069]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Mar 24 15:57:19 volumio volumio[1069]: info: Reading ALSA contributions from plugins.
Mar 24 15:57:19 volumio volumio[1069]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 24 15:57:19 volumio volumio[1069]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Mar 24 15:57:19 volumio volumio[1069]: at Object.readdirSync (fs.js:1048:3)
Mar 24 15:57:19 volumio volumio[1069]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Mar 24 15:57:19 volumio volumio[1069]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Mar 24 15:57:19 volumio volumio[1069]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Mar 24 15:57:19 volumio volumio[1069]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Mar 24 15:57:19 volumio volumio[1069]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Mar 24 15:57:19 volumio volumio[1069]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Mar 24 15:57:19 volumio volumio[1069]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Mar 24 15:57:19 volumio volumio[1069]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Mar 24 15:57:19 volumio volumio[1069]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) {
Mar 24 15:57:19 volumio volumio[1069]: errno: -20,
Mar 24 15:57:19 volumio volumio[1069]: syscall: 'scandir',
Mar 24 15:57:19 volumio volumio[1069]: code: 'ENOTDIR',
Mar 24 15:57:19 volumio volumio[1069]: path: '/tmp/peppyrunning'
Mar 24 15:57:19 volumio volumio[1069]: }
Mar 24 15:57:19 volumio volumio[1069]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 24 15:57:20 volumio sudo[10021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 15:56
Mar 24 15:57:20 volumio sudo[10021]: 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"