-- Logs begin at Sun 2024-10-27 10:23:25 CST, end at Sun 2024-10-27 18:51:06 CST. -- Oct 27 18:50:02 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:02 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:02 volumio volumio[13375]: info: Adding Item to queue: albums://%E5%90%B3%E9%9B%A8%E9%9C%8F/State%20of%20Mind Oct 27 18:50:02 volumio volumio[13375]: info: Exploding uri albums://%E5%90%B3%E9%9B%A8%E9%9C%8F/State%20of%20Mind in service mpd Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand stop took 18 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 27 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand stop took 6 milliseconds Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand clear took 8 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 7 milliseconds Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac" Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: 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":"My January","uri":"NAS/Music/Tidal/吳雨霏 - My January [16538211] [2012]/01 - 吳雨霏 - 遲早.flac","trackType":"flac"} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: No code Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: 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} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: No code Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 107ms Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 70ms Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 73 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 72ms Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac" took 68 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 8ms Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 6ms Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: 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} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: No code Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 105ms Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:02 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 37ms Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand play took 33 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 4ms Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 3ms Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: Oct 27 18:50:02 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:02 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:02 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"574 Kbps","isStreaming":false,"title":"我正在","artist":"吳雨霏","album":"State of Mind","uri":"NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac","trackType":"flac"} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"574 Kbps","isStreaming":false,"title":"我正在","artist":"吳雨霏","album":"State of Mind","uri":"NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac","trackType":"flac"} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:02 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"574 Kbps","isStreaming":false,"title":"我正在","artist":"吳雨霏","album":"State of Mind","uri":"NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac","trackType":"flac"} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:02 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"574 Kbps","isStreaming":false,"title":"我正在","artist":"吳雨霏","album":"State of Mind","uri":"NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac","trackType":"flac"} Oct 27 18:50:02 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:02 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:02 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:02 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 15ms Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 23ms Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 22ms Oct 27 18:50:02 volumio volumio[13375]: info: ------------------------------ 21ms Oct 27 18:50:06 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:06 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:06 volumio volumio[13375]: info: Adding Item to queue: albums://%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8 Oct 27 18:50:06 volumio volumio[13375]: info: Exploding uri albums://%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8 in service mpd Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand stop took 17 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 24 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand stop took 4 milliseconds Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand clear took 5 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 5 milliseconds Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac" Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: 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":"State of Mind","uri":"NAS/Music/Tidal/吳雨霏 - State of Mind [25525149] [2013]/01 - 吳雨霏 - 我正在.flac","trackType":"flac"} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: No code Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: 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} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: No code Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 98ms Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 70ms Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 78 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 78ms Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac" took 74 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 11ms Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 4ms Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: 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} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: No code Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 104ms Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:06 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 34ms Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand play took 31 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 8ms Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 8ms Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: Oct 27 18:50:06 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:06 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:06 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"917 Kbps","isStreaming":false,"title":"豔羨","artist":"吳雨霏","album":"豔羨","uri":"NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac","trackType":"flac"} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"917 Kbps","isStreaming":false,"title":"豔羨","artist":"吳雨霏","album":"豔羨","uri":"NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac","trackType":"flac"} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:06 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"917 Kbps","isStreaming":false,"title":"豔羨","artist":"吳雨霏","album":"豔羨","uri":"NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac","trackType":"flac"} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:06 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"917 Kbps","isStreaming":false,"title":"豔羨","artist":"吳雨霏","album":"豔羨","uri":"NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac","trackType":"flac"} Oct 27 18:50:06 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:06 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:06 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:06 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 15ms Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 22ms Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 19ms Oct 27 18:50:06 volumio volumio[13375]: info: ------------------------------ 18ms Oct 27 18:50:08 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 27 18:50:08 volumio volumio[13375]: info: CURURI: albums://%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8 Oct 27 18:50:08 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/02 - 吳雨霏 - 一分鐘稀客一分鐘色誘.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/03 - 吳雨霏 - 想入非非.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/04 - 吳雨霏 - 一千個假想結局.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/05 - 吳雨霏 - 流螢.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/06 - 吳雨霏 - 我敢愛.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/07 - 吳雨霏 - 超男友.flac Oct 27 18:50:08 volumio volumio[13375]: info: Preloading song: music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/08 - 吳雨霏 - 真過份.flac Oct 27 18:50:08 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac in service mpd Oct 27 18:50:08 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F01%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8.flac&metadata=false Oct 27 18:50:08 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac Oct 27 18:50:08 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/02 - 吳雨霏 - 一分鐘稀客一分鐘色誘.flac in service mpd Oct 27 18:50:08 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F02%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E4%B8%80%E5%88%86%E9%90%98%E7%A8%80%E5%AE%A2%E4%B8%80%E5%88%86%E9%90%98%E8%89%B2%E8%AA%98.flac&metadata=false Oct 27 18:50:08 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/02 - 吳雨霏 - 一分鐘稀客一分鐘色誘.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/03 - 吳雨霏 - 想入非非.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F03%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E6%83%B3%E5%85%A5%E9%9D%9E%E9%9D%9E.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/03 - 吳雨霏 - 想入非非.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/04 - 吳雨霏 - 一千個假想結局.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F04%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E4%B8%80%E5%8D%83%E5%80%8B%E5%81%87%E6%83%B3%E7%B5%90%E5%B1%80.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/04 - 吳雨霏 - 一千個假想結局.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/05 - 吳雨霏 - 流螢.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F05%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E6%B5%81%E8%9E%A2.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/05 - 吳雨霏 - 流螢.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/06 - 吳雨霏 - 我敢愛.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F06%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E6%88%91%E6%95%A2%E6%84%9B.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/06 - 吳雨霏 - 我敢愛.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/07 - 吳雨霏 - 超男友.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F07%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B6%85%E7%94%B7%E5%8F%8B.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/07 - 吳雨霏 - 超男友.flac Oct 27 18:50:09 volumio volumio[13375]: info: Exploding uri music-library/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/08 - 吳雨霏 - 真過份.flac in service mpd Oct 27 18:50:09 volumio volumio[13375]: info: ALBUMART /albumart?cacheid=754&web=%E5%90%B3%E9%9B%A8%E9%9C%8F/%E8%B1%94%E7%BE%A8/large&path=%2Fmnt%2FNAS%2FMusic%2FTidal%2F%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E8%B1%94%E7%BE%A8%20%5B43461137%5D%20%5B2015%5D%2F08%20-%20%E5%90%B3%E9%9B%A8%E9%9C%8F%20-%20%E7%9C%9F%E9%81%8E%E4%BB%BD.flac&metadata=false Oct 27 18:50:09 volumio volumio[13375]: info: URI /mnt/NAS/Music/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/08 - 吳雨霏 - 真過份.flac Oct 27 18:50:17 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:17 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:17 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:17 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:17 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:17 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:17 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:17 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:17 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:17 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:17 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:17 volumio volumio[13375]: info: Adding Item to queue: albums://Yanzi%20Sun/Sun%20Yan%20Zi%20-%20Stefanie Oct 27 18:50:17 volumio volumio[13375]: info: Exploding uri albums://Yanzi%20Sun/Sun%20Yan%20Zi%20-%20Stefanie in service mpd Oct 27 18:50:17 volumio volumio[13375]: info: Oct 27 18:50:17 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:17 volumio volumio[13375]: info: sendMpdCommand stop took 18 milliseconds Oct 27 18:50:17 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 23 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand stop took 6 milliseconds Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand clear took 4 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac" Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: 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/Tidal/吳雨霏 - 豔羨 [43461137] [2015]/01 - 吳雨霏 - 豔羨.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: No code Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: 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} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: No code Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: 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} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: No code Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 116ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 91ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 101ms Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 110ms Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac" took 109 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 10ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 7ms Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:18 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 72ms Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand play took 70 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 69ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 67ms Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 6 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: Oct 27 18:50:18 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 8 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 6 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:18 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 39ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 72ms Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 60 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 60 milliseconds Oct 27 18:50:18 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 59 milliseconds Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:18 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:18 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:18 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:18 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:18 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:18 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:18 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 100ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 97ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 95ms Oct 27 18:50:18 volumio volumio[13375]: info: ------------------------------ 93ms Oct 27 18:50:20 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:20 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:20 volumio volumio[13375]: info: Adding Item to queue: albums://Leslie%20Cheung/Hot%20Summer Oct 27 18:50:20 volumio volumio[13375]: info: Exploding uri albums://Leslie%20Cheung/Hot%20Summer in service mpd Oct 27 18:50:20 volumio volumio[13375]: info: Oct 27 18:50:20 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand stop took 22 milliseconds Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand status took 20 milliseconds Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand stop took 6 milliseconds Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:20 volumio volumio[13375]: info: Oct 27 18:50:20 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:20 volumio volumio[13375]: info: Oct 27 18:50:20 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:20 volumio volumio[13375]: info: Oct 27 18:50:20 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:20 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand clear took 5 milliseconds Oct 27 18:50:20 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac" Oct 27 18:50:20 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: 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":"Running","artist":"Yanzi Sun","album":"Sun Yan Zi - Stefanie","uri":"NAS/Music/Tidal/孙燕姿 - Sun Yan Zi - Stefanie [482299] [2004]/01 - Yanzi Sun - Running.flac","trackType":"flac"} Oct 27 18:50:20 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: No code Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: 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} Oct 27 18:50:20 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:20 volumio volumio[13375]: info: No code Oct 27 18:50:20 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:20 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:20 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 93ms Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 69ms Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:21 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:21 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:21 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:21 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand status took 71 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 70ms Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac" took 69 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 5ms Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: 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} Oct 27 18:50:21 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: No code Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 153ms Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:21 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:21 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 94ms Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand play took 92 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 13ms Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 12ms Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:21 volumio volumio[13375]: info: Oct 27 18:50:21 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:21 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:21 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"887 Kbps","isStreaming":false,"title":"Hot Summer","artist":"Leslie Cheung","album":"Hot Summer","uri":"NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac","trackType":"flac"} Oct 27 18:50:21 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"887 Kbps","isStreaming":false,"title":"Hot Summer","artist":"Leslie Cheung","album":"Hot Summer","uri":"NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac","trackType":"flac"} Oct 27 18:50:21 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:21 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"887 Kbps","isStreaming":false,"title":"Hot Summer","artist":"Leslie Cheung","album":"Hot Summer","uri":"NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac","trackType":"flac"} Oct 27 18:50:21 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:21 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"887 Kbps","isStreaming":false,"title":"Hot Summer","artist":"Leslie Cheung","album":"Hot Summer","uri":"NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac","trackType":"flac"} Oct 27 18:50:21 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:21 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:21 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:21 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 25ms Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 50ms Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 47ms Oct 27 18:50:21 volumio volumio[13375]: info: ------------------------------ 46ms Oct 27 18:50:24 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:24 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:24 volumio volumio[13375]: info: Adding Item to queue: albums://%E5%BC%B5%E5%AD%B8%E5%8F%8B/%E7%9B%B8%E6%84%9B Oct 27 18:50:24 volumio volumio[13375]: info: Exploding uri albums://%E5%BC%B5%E5%AD%B8%E5%8F%8B/%E7%9B%B8%E6%84%9B in service mpd Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand stop took 20 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand status took 24 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand stop took 4 milliseconds Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand clear took 3 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac" Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: 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":"Hot Summer","artist":"Leslie Cheung","album":"Hot Summer","uri":"NAS/Music/Tidal/张国荣 - Hot Summer [91958949] [2015]/01 - Leslie Cheung - Hot Summer.flac","trackType":"flac"} Oct 27 18:50:24 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: No code Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: 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} Oct 27 18:50:24 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: No code Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 99ms Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 71ms Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand status took 77 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 77ms Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac" took 76 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 8ms Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 6ms Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:24 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:24 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: 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} Oct 27 18:50:24 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: No code Oct 27 18:50:24 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:24 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:24 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 102ms Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: info: Oct 27 18:50:24 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:24 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 33ms Oct 27 18:50:24 volumio volumio[13375]: info: sendMpdCommand play took 31 milliseconds Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 7ms Oct 27 18:50:24 volumio volumio[13375]: info: ------------------------------ 6ms Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: Oct 27 18:50:25 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 20 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 19 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 19 milliseconds Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 9 milliseconds Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 4 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"934 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":660,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"926 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:25 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":774,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"926 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:25 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"885 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:25 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 32ms Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 41ms Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 41ms Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 38ms Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 27 18:50:25 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 23 milliseconds Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"885 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:25 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"885 Kbps","isStreaming":false,"title":"別戀","artist":"張學友","album":"相愛","uri":"NAS/Music/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:25 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:25 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:25 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:25 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 48ms Oct 27 18:50:25 volumio volumio[13375]: info: ------------------------------ 46ms Oct 27 18:50:27 volumio nmbd[884]: [2024/10/27 18:50:27.525945, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 27 18:50:27 volumio nmbd[884]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.222 for name WORKGROUP<1d>. Oct 27 18:50:27 volumio nmbd[884]: This response was from IP 192.168.10.5, reporting an IP address of 192.168.10.5. Oct 27 18:50:28 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::ClearQueue Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::clearPlayQueue Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::addQueueItems Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::addQueueItems Oct 27 18:50:28 volumio volumio[13375]: info: Preload queue cleared Oct 27 18:50:28 volumio volumio[13375]: info: Adding Item to queue: albums://%E5%BC%B5%E9%9F%B6%E6%B6%B5/Over%20The%20Rainbow Oct 27 18:50:28 volumio volumio[13375]: info: Exploding uri albums://%E5%BC%B5%E9%9F%B6%E6%B6%B5/Over%20The%20Rainbow in service mpd Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand stop took 21 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushQueue Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::saveQueue Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::play index 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 18 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand stop took 4 milliseconds Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand clear took 6 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac" Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: 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/Tidal/張學友 - 相愛 [13355315] [2010]/01 - 張學友 - 別戀.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: No code Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: 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} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: No code Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 70ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 47ms Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 51 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 51ms Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac" took 49 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 8ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 7ms Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: 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} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: No code Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 83ms Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:28 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 61ms Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand play took 56 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 27ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 20ms Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: Oct 27 18:50:28 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 13 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 12 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 17ms Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 18:50:28 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:28 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"412 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:28 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:28 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:28 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:28 volumio volumio[13375]: verbose: CURRENT POSITION 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:28 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:28 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:28 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 48ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 47ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 48ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 37ms Oct 27 18:50:28 volumio volumio[13375]: info: ------------------------------ 37ms Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPlay Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::play index 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::stop Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::stPlaybackTimer Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::updateTrackBlock Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrackBlock Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::serviceStop Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 0 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::serviceStop Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::stop Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand stop took 2 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::play index undefined Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::startPlaybackTimer Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 3 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand stop took 2 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 2 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand clear took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac" Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: 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":"Over The Rainbow","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/01 - 張韶涵 - Over The Rainbow.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService stop Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: No code Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 12ms Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 11ms Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: error: updateQueue error: null Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 10ms Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand add "NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac" took 9 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 1ms Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand play Oct 27 18:50:35 volumio volumio[13375]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 11ms Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces system playlist update Oct 27 18:50:35 volumio volumio[13375]: info: Ignoring MPD Status Update Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 2ms Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand play took 2 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 2ms Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 0 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 0 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 1 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: info: Oct 27 18:50:35 volumio volumio[13375]: ---------------------------- MPD announces state update: player Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::getState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand status Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus stop Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:35 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:35 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:35 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:35 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 9ms Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 24ms Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 24ms Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 24ms Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 24ms Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand status took 23 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseState Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 18:50:35 volumio volumio[13375]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 18:50:35 volumio volumio[13375]: verbose: ControllerMpd::parseTrackInfo Oct 27 18:50:35 volumio volumio[13375]: info: ControllerMpd::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::servicePushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"寓言","artist":"張韶涵","album":"Over The Rainbow","uri":"NAS/Music/Tidal/張韶涵 - Over The Rainbow [252719209] [2004]/02 - 張韶涵 - 寓言.flac","trackType":"flac"} Oct 27 18:50:35 volumio volumio[13375]: verbose: CURRENT POSITION 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState stateService play Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::syncState currentStatus play Oct 27 18:50:35 volumio volumio[13375]: info: Received an update from plugin. extracting info from payload Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: CoreStateMachine::pushState Oct 27 18:50:35 volumio volumio[13375]: info: CorePlayQueue::getTrack 1 Oct 27 18:50:35 volumio volumio[13375]: info: CoreCommandRouter::volumioPushState Oct 27 18:50:35 volumio volumio[13375]: info: ------------------------------ 30ms Oct 27 18:50:57 volumio volumio-remote-updater[1521]: No test mode Oct 27 18:50:57 volumio volumio-remote-updater[1521]: No alpha test mode Oct 27 18:50:57 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 27 18:50:58 volumio volumio[13375]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 27 18:50:58 volumio volumio[13375]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 27 18:51:06 volumio volumio[13375]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 18:51:06 volumio volumio[13375]: Error: connect ETIMEDOUT 31.13.82.169:80 Oct 27 18:51:06 volumio volumio[13375]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 27 18:51:06 volumio volumio[13375]: errno: -110, Oct 27 18:51:06 volumio volumio[13375]: code: 'ETIMEDOUT', Oct 27 18:51:06 volumio volumio[13375]: syscall: 'connect', Oct 27 18:51:06 volumio volumio[13375]: address: '31.13.82.169', Oct 27 18:51:06 volumio volumio[13375]: port: 80 Oct 27 18:51:06 volumio volumio[13375]: } Oct 27 18:51:06 volumio volumio[13375]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 18:51:06 volumio sudo[13684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-27 18:50 Oct 27 18:51:06 volumio sudo[13684]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"