-- Logs begin at Mon 2025-05-19 13:59:48 CST, end at Tue 2025-05-20 10:28:02 CST. -- May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 25 milliseconds May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: info: May 20 10:27:00 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 27 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 27 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 4 milliseconds May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1102 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 40ms May 20 10:27:00 volumio volumio[8324]: info: May 20 10:27:00 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:00 volumio volumio[8324]: info: May 20 10:27:00 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 15 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 13 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 12 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1102 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:00 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:00 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 130ms May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 130ms May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand status took 92 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 88 milliseconds May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 86 milliseconds May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:00 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:00 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 175ms May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 165ms May 20 10:27:00 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 82 milliseconds May 20 10:27:00 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:00 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63,"duration":7232,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:00 volumio volumio[8324]: verbose: CURRENT POSITION 13 May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:00 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:00 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:00 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:00 volumio volumio[8324]: info: ------------------------------ 202ms May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 13 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand stop took 17 milliseconds May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/独家高端音响系统.flac May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand stop took 2 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 4 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand clear took 5 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 2 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/独家高端音响系统.flac" May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"清澈如水晶的 24 位.flac","artist":null,"album":null,"uri":"NAS/Music/清澈如水晶的 24 位.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: No code May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: 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} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: No code May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: 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} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: No code May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 122ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 117ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 117ms May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 123ms May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/独家高端音响系统.flac" took 121 milliseconds May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 8ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 6ms May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:03 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 28ms May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand play took 24 milliseconds May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 23ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 22ms May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 25 milliseconds May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 27 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 25 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: May 20 10:27:03 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 14 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:03 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:03 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 75ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 114ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 113ms May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand status took 80 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 75 milliseconds May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 74 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:03 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:03 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 181ms May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 171ms May 20 10:27:03 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 100 milliseconds May 20 10:27:03 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:03 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63,"duration":5100,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1177 Kbps","isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:03 volumio volumio[8324]: verbose: CURRENT POSITION 14 May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:03 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:03 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:03 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:03 volumio volumio[8324]: info: ------------------------------ 227ms May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 14 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand stop took 27 milliseconds May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/白鸽伍佰.flac May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand stop took 1 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 4 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand clear took 5 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/白鸽伍佰.flac" May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"独家高端音响系统.flac","artist":null,"album":null,"uri":"NAS/Music/独家高端音响系统.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: No code May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: 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} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: No code May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: 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} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: No code May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 91ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 86ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 86ms May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 89ms May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/白鸽伍佰.flac" took 84 milliseconds May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:05 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 19ms May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand play took 18 milliseconds May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 17ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 16ms May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 21 milliseconds May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 22 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 22 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: May 20 10:27:05 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 6 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:05 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:05 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:05 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 60ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 113ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 114ms May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 96ms May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand status took 88 milliseconds May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 83 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:05 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 126ms May 20 10:27:05 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 49 milliseconds May 20 10:27:05 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:05 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"白鸽","artist":"伍佰","album":null,"uri":"NAS/Music/白鸽伍佰.flac","trackType":"flac"} May 20 10:27:05 volumio volumio[8324]: verbose: CURRENT POSITION 15 May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:05 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:05 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:05 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:05 volumio volumio[8324]: info: ------------------------------ 171ms May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 15 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand stop took 16 milliseconds May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand stop took 2 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand clear took 4 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac" May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: 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} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: No code May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: 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} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: No code May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 53ms May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 52ms May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 56ms May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 54 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac" took 55 milliseconds May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 5ms May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:07 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 64ms May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:07 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 17ms May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand play took 15 milliseconds May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 14ms May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 13ms May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 24 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 38 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 16 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 49ms May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: May 20 10:27:07 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 14 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 12 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 11 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 7 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1157 Kbps","isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:07 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1157 Kbps","isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:07 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 120ms May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 120ms May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand status took 75 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 71 milliseconds May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 71 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1157 Kbps","isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:07 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1157 Kbps","isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:07 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 168ms May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 159ms May 20 10:27:07 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 90 milliseconds May 20 10:27:07 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:07 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":147,"duration":300,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1197 Kbps","isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:07 volumio volumio[8324]: verbose: CURRENT POSITION 16 May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:07 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:07 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:07 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:07 volumio volumio[8324]: info: ------------------------------ 218ms May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 16 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand stop took 50 milliseconds May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/相守.flac May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand stop took 2 milliseconds May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 5 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand clear took 5 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/相守.flac" May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","artist":null,"album":null,"uri":"NAS/Music/目前这首歌全网最好听,此曲只应天上有,人间难得几回闻.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: No code May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: 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} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: No code May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: 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} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: No code May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 78ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 73ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 73ms May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 75ms May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/相守.flac" took 72 milliseconds May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 3ms May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:09 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 15ms May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand play took 13 milliseconds May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 12ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 11ms May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 22 milliseconds May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 22 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 21 milliseconds May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: May 20 10:27:09 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 11 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 8 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 7 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"760 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:09 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"760 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:09 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 77ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 126ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 126ms May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 91 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 90 milliseconds May 20 10:27:09 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 90 milliseconds May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:09 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"760 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:09 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"760 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:09 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":318,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"760 Kbps","isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:09 volumio volumio[8324]: verbose: CURRENT POSITION 17 May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:09 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:09 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:09 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 210ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 202ms May 20 10:27:09 volumio volumio[8324]: info: ------------------------------ 210ms May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 17 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand stop took 26 milliseconds May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/超长版神曲,适合自驾游时听.flac May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 7 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand stop took 6 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand clear took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/超长版神曲,适合自驾游时听.flac" May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相守.flac","artist":null,"album":null,"uri":"NAS/Music/相守.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: No code May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:12 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 44ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 40ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 39ms May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 31ms May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/超长版神曲,适合自驾游时听.flac" took 30 milliseconds May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 3ms May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:12 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 9ms May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand play took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 7ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 6ms May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 24 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 23 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 23 milliseconds May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: May 20 10:27:12 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 8 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:12 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:12 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 60ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 99ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 99ms May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand status took 72 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 73 milliseconds May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 72 milliseconds May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:12 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:12 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 140ms May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 136ms May 20 10:27:12 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 76 milliseconds May 20 10:27:12 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:12 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":560,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"超长版神曲,适合自驾游时听.flac","artist":null,"album":null,"uri":"NAS/Music/超长版神曲,适合自驾游时听.flac","trackType":"flac"} May 20 10:27:12 volumio volumio[8324]: verbose: CURRENT POSITION 18 May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:12 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:12 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:12 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:12 volumio volumio[8324]: info: ------------------------------ 190ms May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 18 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand stop took 13 milliseconds May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/高解析HIFI 试音极品 无损.flac May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand stop took 3 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand clear took 4 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/高解析HIFI 试音极品 无损.flac" May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: 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} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: No code May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 30ms May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:15 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 33ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 32ms May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 30 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/高解析HIFI 试音极品 无损.flac" took 30 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:15 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:15 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 40ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 39ms May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 21ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 20ms May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand play took 18 milliseconds May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 18ms May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:15 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 5ms May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 20 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 18 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 15 milliseconds May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: May 20 10:27:15 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 9 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:15 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:15 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:15 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 72ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 148ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 147ms May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 133ms May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand status took 123 milliseconds May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 112 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:15 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 161ms May 20 10:27:15 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 45 milliseconds May 20 10:27:15 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:15 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":1274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:15 volumio volumio[8324]: verbose: CURRENT POSITION 19 May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:15 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:15 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:15 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:15 volumio volumio[8324]: info: ------------------------------ 199ms May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 19 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand stop took 13 milliseconds May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/吻别张学友.flac May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand stop took 2 milliseconds May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand status took 2 milliseconds May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 3 milliseconds May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand clear took 3 milliseconds May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 3 milliseconds May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand status took 2 milliseconds May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/吻别张学友.flac" May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"高解析HIFI 试音极品 无损.flac","artist":null,"album":null,"uri":"NAS/Music/高解析HIFI 试音极品 无损.flac","trackType":"flac"} May 20 10:27:17 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: No code May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: 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} May 20 10:27:17 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: No code May 20 10:27:17 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:17 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:17 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 54ms May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 51ms May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 49ms May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 52ms May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/吻别张学友.flac" took 51 milliseconds May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 3ms May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:17 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 16ms May 20 10:27:17 volumio volumio[8324]: info: sendMpdCommand play took 15 milliseconds May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 14ms May 20 10:27:17 volumio volumio[8324]: info: ------------------------------ 10ms May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:17 volumio volumio[8324]: info: May 20 10:27:17 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:17 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:17 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:18 volumio volumio[8324]: info: May 20 10:27:18 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 24 milliseconds May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 25 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 24 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: info: May 20 10:27:18 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:18 volumio volumio[8324]: info: May 20 10:27:18 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 6 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 7 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"840 Kbps","isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:18 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1026 Kbps","isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:18 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1026 Kbps","isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:18 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 63ms May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 141ms May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 141ms May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 122ms May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 109 milliseconds May 20 10:27:18 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 108 milliseconds May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:18 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1026 Kbps","isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:18 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1026 Kbps","isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:18 volumio volumio[8324]: verbose: CURRENT POSITION 20 May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:18 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:18 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:18 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 182ms May 20 10:27:18 volumio volumio[8324]: info: ------------------------------ 181ms May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 20 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand stop took 19 milliseconds May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/天意-刘德华.flac May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand stop took 3 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 2 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand clear took 2 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 3 milliseconds May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/天意-刘德华.flac" May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"吻别","artist":"张学友","album":"吻别","uri":"NAS/Music/吻别张学友.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: No code May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 36ms May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 34ms May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 30ms May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 29 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/天意-刘德华.flac" took 29 milliseconds May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:19 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 43ms May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 16ms May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 14ms May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand play took 7 milliseconds May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 6ms May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:19 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 32 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 30 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 29 milliseconds May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: May 20 10:27:19 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 11 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 11 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"716 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:19 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:19 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 73ms May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 108ms May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 109ms May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 75 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand status took 74 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 72 milliseconds May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:19 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 114ms May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 50 milliseconds May 20 10:27:19 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 51 milliseconds May 20 10:27:19 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:19 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:19 volumio volumio[8324]: verbose: CURRENT POSITION 21 May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:19 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:19 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:19 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 198ms May 20 10:27:19 volumio volumio[8324]: info: ------------------------------ 197ms May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 21 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand stop took 15 milliseconds May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/天涯爱乐团王超.flac May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand stop took 3 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 1 milliseconds May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 3 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand clear took 3 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 3 milliseconds May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/天涯爱乐团王超.flac" May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天意","artist":"刘德华","album":"天意","uri":"NAS/Music/天意-刘德华.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: No code May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 33ms May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 30ms May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 28 milliseconds May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 27ms May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/天涯爱乐团王超.flac" took 27 milliseconds May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: 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} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: No code May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 57ms May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 52ms May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 50ms May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand play took 49 milliseconds May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 21ms May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:20 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 7 milliseconds May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 7ms May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 5ms May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: May 20 10:27:20 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 12 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 11 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 12 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 9 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand status took 7 milliseconds May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"992 Kbps","isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"992 Kbps","isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:20 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 43ms May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 58ms May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 39 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 39 milliseconds May 20 10:27:20 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 38 milliseconds May 20 10:27:20 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1045 Kbps","isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:20 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1045 Kbps","isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:20 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1045 Kbps","isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:20 volumio volumio[8324]: verbose: CURRENT POSITION 22 May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:20 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:20 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:20 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 145ms May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 141ms May 20 10:27:20 volumio volumio[8324]: info: ------------------------------ 140ms May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 22 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand stop took 20 milliseconds May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/过火张信哲.flac May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand stop took 4 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 2 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 4 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 2 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand clear took 2 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 2 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/过火张信哲.flac" May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天涯","artist":"爱乐团王超","album":"天涯","uri":"NAS/Music/天涯爱乐团王超.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: No code May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 36ms May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 34ms May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 32ms May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 30 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/过火张信哲.flac" took 31 milliseconds May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:22 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 38ms May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 10ms May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 8ms May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand play took 6 milliseconds May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 6ms May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:22 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 2ms May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 26 milliseconds May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 26 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 26 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: May 20 10:27:22 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 11 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 10 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 8 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:22 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:22 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 61ms May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 95ms May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 95ms May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand status took 64 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 59 milliseconds May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 58 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:22 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"740 Kbps","isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:22 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 126ms May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 120ms May 20 10:27:22 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 75 milliseconds May 20 10:27:22 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:22 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"740 Kbps","isStreaming":false,"title":"过火","artist":"张信哲","album":"宽容","uri":"NAS/Music/过火张信哲.flac","trackType":"flac"} May 20 10:27:22 volumio volumio[8324]: verbose: CURRENT POSITION 23 May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:22 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:22 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:22 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:22 volumio volumio[8324]: info: ------------------------------ 173ms May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioNext May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::next May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::stPlaybackTimer May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::serviceStop May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 23 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::serviceStop May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::stop May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand stop took 23 milliseconds May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::play index undefined May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::startPlaybackTimer May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::updateTrackBlock May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrackBlock May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand stop took 3 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand clear May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 8 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand clear took 12 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 6 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 5 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac" May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: 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} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: No code May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: 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} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: No code May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 52ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 52ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 60ms May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: error: updateQueue error: null May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 51ms May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand add "NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac" took 50 milliseconds May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 4ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 3ms May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand play May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces system playlist update May 20 10:27:23 volumio volumio[8324]: info: Ignoring MPD Status Update May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 13ms May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand play took 12 milliseconds May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 12ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 10ms May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 23 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 25 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 24 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 4 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"511 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus stop May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 34ms May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: May 20 10:27:23 volumio volumio[8324]: ---------------------------- MPD announces state update: player May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::getState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand status May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 12 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 5 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand status took 3 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseState May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:23 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:23 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 97ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 103ms May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 68 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 67 milliseconds May 20 10:27:23 volumio volumio[8324]: info: sendMpdCommand playlistinfo took 67 milliseconds May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:23 volumio volumio[8324]: verbose: ControllerMpd::parseTrackInfo May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:23 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:23 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ControllerMpd::pushState May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::servicePushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","artist":null,"album":null,"uri":"NAS/Music/《远去的星空》陈瑞又一首好听歌曲不亚于《白狐》延时星空欣赏 - 今日头条_QQ浏览器格式转换_QQ浏览器转格式.flac","trackType":"flac"} May 20 10:27:23 volumio volumio[8324]: verbose: CURRENT POSITION 24 May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState stateService play May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::syncState currentStatus play May 20 10:27:23 volumio volumio[8324]: info: Received an update from plugin. extracting info from payload May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:23 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:23 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 183ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 176ms May 20 10:27:23 volumio volumio[8324]: info: ------------------------------ 175ms May 20 10:27:30 volumio volumio[8324]: info: VolumeController::SetAlsaVolume+ May 20 10:27:30 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:30 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:30 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:30 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:27:31 volumio volumio[8324]: info: VolumeController::SetAlsaVolume+ May 20 10:27:31 volumio volumio[8324]: info: CoreStateMachine::pushState May 20 10:27:31 volumio volumio[8324]: info: CorePlayQueue::getTrack 24 May 20 10:27:31 volumio volumio[8324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 10:27:31 volumio volumio[8324]: info: CoreCommandRouter::volumioPushState May 20 10:28:01 volumio volumio[8324]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 10:28:01 volumio volumio[8324]: Error: connect ETIMEDOUT 162.125.32.5:80 May 20 10:28:01 volumio volumio[8324]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 20 10:28:01 volumio volumio[8324]: errno: -110, May 20 10:28:01 volumio volumio[8324]: code: 'ETIMEDOUT', May 20 10:28:01 volumio volumio[8324]: syscall: 'connect', May 20 10:28:01 volumio volumio[8324]: address: '162.125.32.5', May 20 10:28:01 volumio volumio[8324]: port: 80 May 20 10:28:01 volumio volumio[8324]: } May 20 10:28:01 volumio volumio[8324]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 10:28:02 volumio sudo[10793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 10:27 May 20 10:28:02 volumio sudo[10793]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"