-- Logs begin at Sat 2024-03-30 09:38:10 HKT, end at Sat 2024-03-30 13:27:35 HKT. -- Mar 30 13:26:12 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: sendMpdCommand stop took 11 milliseconds Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:13 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:13 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: No code Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 9ms Mar 30 13:26:13 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:13 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 11ms Mar 30 13:26:13 volumio volumio[7872]: info: sendMpdCommand status took 11 milliseconds Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 11ms Mar 30 13:26:13 volumio volumio[7872]: info: sendMpdCommand status took 11 milliseconds Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:13 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: No code Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:13 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: No code Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 23ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 24ms Mar 30 13:26:13 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:26:13 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:26:13 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:26:13 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:13 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:13 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:13 volumio volumio[7872]: info: Mar 30 13:26:13 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:13 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:13 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 16ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 19ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 17 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":456,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/EA664186-8D0C-4D52-9807-AE8AF982BB8D/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 30ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 30ms Mar 30 13:26:14 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand stop took 6 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 3ms Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: No code Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: No code Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: No code Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 20ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 20ms Mar 30 13:26:14 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:26:14 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:26:14 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:14 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: Mar 30 13:26:14 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:14 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:14 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:14 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:14 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:14 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:14 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 13ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 16ms Mar 30 13:26:14 volumio volumio[7872]: info: ------------------------------ 16ms Mar 30 13:26:44 volumio volumio[7872]: info: Mar 30 13:26:44 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:44 volumio volumio[7872]: info: Mar 30 13:26:44 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:44 volumio volumio[7872]: info: Mar 30 13:26:44 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:44 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:44 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:44 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:44 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:44 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":435000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:44 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:44 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:44 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:44 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":435000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:44 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:44 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: ------------------------------ 12ms Mar 30 13:26:44 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 30 13:26:44 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:44 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:44 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:44 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":435000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:44 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:44 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:44 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:44 volumio volumio[7872]: info: ------------------------------ 19ms Mar 30 13:26:47 volumio volumio[7872]: info: Mar 30 13:26:47 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:47 volumio volumio[7872]: info: Mar 30 13:26:47 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:47 volumio volumio[7872]: info: Mar 30 13:26:47 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:47 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:47 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:47 volumio volumio[7872]: info: sendMpdCommand status took 0 milliseconds Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:47 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:47 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:47 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:47 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1268000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:47 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:47 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:47 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:47 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1268000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:47 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:47 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:47 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:47 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1268000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:47 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:47 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:47 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:47 volumio volumio[7872]: info: ------------------------------ 19ms Mar 30 13:26:47 volumio volumio[7872]: info: ------------------------------ 19ms Mar 30 13:26:47 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:26:50 volumio volumio[7872]: info: Mar 30 13:26:50 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:50 volumio volumio[7872]: info: Mar 30 13:26:50 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:50 volumio volumio[7872]: info: Mar 30 13:26:50 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:50 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:50 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2211000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:50 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:50 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:50 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:50 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2211000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:50 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:50 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: ------------------------------ 10ms Mar 30 13:26:50 volumio volumio[7872]: info: ------------------------------ 9ms Mar 30 13:26:50 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 30 13:26:50 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:50 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:50 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:50 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2211000,"duration":3625,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"唐朝 - 梦回唐朝 by husi0997","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/7DE3BD3D-208F-4548-876F-8A946321493A/1000.wav","trackType":"wav"} Mar 30 13:26:50 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:50 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:50 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:50 volumio volumio[7872]: info: ------------------------------ 12ms Mar 30 13:26:56 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:56 volumio volumio[7872]: info: sendMpdCommand stop took 6 milliseconds Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:56 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:56 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:56 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: No code Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 7ms Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:56 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 7ms Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:56 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:56 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:56 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:26:56 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:56 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:56 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: No code Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:56 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: No code Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 13ms Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 12ms Mar 30 13:26:56 volumio volumio[7872]: info: Mar 30 13:26:56 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:56 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:56 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:56 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:56 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:26:56 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:26:56 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:26:56 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:56 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 5 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 12ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 12ms Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 9ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 8 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":410,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":433,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":456,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"173 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"725 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 28ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 26ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 26ms Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/C83D28A5-EF43-4BC2-8A7D-2B0FB9E9EA5B/1000.flac","trackType":"flac"} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:57 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 40ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 34ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 34ms Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:57 volumio volumio[1365]: Connection was closed while sending response headers. Mar 30 13:26:57 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand stop took 6 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:57 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:57 volumio volumio[7872]: info: Mar 30 13:26:57 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:57 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:57 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:57 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 3ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:57 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:57 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: No code Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: No code Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:26:57 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: No code Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 15ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 15ms Mar 30 13:26:57 volumio volumio[7872]: info: ------------------------------ 14ms Mar 30 13:26:57 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:26:57 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:26:57 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:26:57 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:26:57 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 9ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 10ms Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"观音","artist":"唐晓诗 (Performer)","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 24ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 23ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 22ms Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 30 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 30ms Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 29 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:26:58 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:26:58 volumio volumio[7872]: info: Mar 30 13:26:58 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 8 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 5ms Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand status took 5 milliseconds Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 47ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 46ms Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 30 13:26:58 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:58 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"691 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:26:58 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:26:58 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"691 Kbps","isStreaming":false,"title":"观音","artist":"唐晓诗","album":"唐晓诗专辑","uri":"http://192.168.1.168:10246/MDEServer/013BF4D4-284A-42E2-8753-142F4690EFD6/1000.flac","trackType":"flac"} Mar 30 13:26:58 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:26:58 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 29ms Mar 30 13:26:58 volumio volumio[7872]: info: ------------------------------ 26ms Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreCommandRouter::volumioGetQueue Mar 30 13:26:58 volumio volumio[7872]: info: CoreStateMachine::getQueue Mar 30 13:26:58 volumio volumio[7872]: info: CorePlayQueue::getQueue Mar 30 13:27:19 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:19 volumio volumio[7872]: info: sendMpdCommand stop took 5 milliseconds Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:19 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:19 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:19 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: No code Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 8ms Mar 30 13:27:19 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:27:19 volumio volumio[7872]: info: sendMpdCommand status took 7 milliseconds Mar 30 13:27:19 volumio volumio[7872]: info: sendMpdCommand status took 7 milliseconds Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 6ms Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:19 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:19 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: No code Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:19 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: No code Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 18ms Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 18ms Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:19 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:19 volumio volumio[7872]: info: Mar 30 13:27:19 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:19 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:19 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 8ms Mar 30 13:27:19 volumio volumio[7872]: info: ------------------------------ 7ms Mar 30 13:27:19 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:27:19 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:27:19 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:27:19 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:19 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 2ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 6 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 4 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:20 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 18ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 17ms Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:20 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:20 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:20 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/6544E3F7-EE4D-4C4A-8E3D-B6ECAAC95850/1000.wav","trackType":"wav"} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:20 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 31ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 30ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 28ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 27ms Mar 30 13:27:20 volumio volumio[7872]: info: Clearing queue after UPNP request Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::ClearQueue Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::updateTrackBlock Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrackBlock Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::serviceStop Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::stop Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::clearPlayQueue Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::saveQueue Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushQueue Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand stop took 6 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:27:20 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: No code Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: No code Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 30 13:27:20 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState stateService stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: No code Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 20ms Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: info: Mar 30 13:27:20 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:20 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:20 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 21ms Mar 30 13:27:20 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:27:20 volumio volumio[7872]: error: updateQueue error: null Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 10ms Mar 30 13:27:20 volumio volumio[7872]: info: ------------------------------ 10ms Mar 30 13:27:20 volumio volumio[7872]: info: Starting UPNP Playback Mar 30 13:27:20 volumio volumio[7872]: info: Preparing playback through UPNP Mar 30 13:27:20 volumio volumio[7872]: info: CoreCommandRouter::volumioGetState Mar 30 13:27:20 volumio volumio[7872]: info: CorePlayQueue::getTrack 0 Mar 30 13:27:20 volumio volumio[7872]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces system playlist update Mar 30 13:27:21 volumio volumio[7872]: info: Ignoring MPD Status Update Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 1ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 0ms Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: Mar 30 13:27:21 volumio volumio[7872]: ---------------------------- MPD announces state update: player Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand status took 3 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::getState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand status Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand status took 2 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand status took 1 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseState Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus stop Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:21 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:21 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:21 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 22ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 26ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 25ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 25ms Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 30 13:27:21 volumio volumio[7872]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:21 volumio volumio[7872]: verbose: ControllerMpd::parseTrackInfo Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:21 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: ControllerMpd::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::servicePushState Mar 30 13:27:21 volumio volumio[7872]: verbose: In UPNP mode Mar 30 13:27:21 volumio volumio[7872]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":2416,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"太極樂隊 - 迷","artist":null,"album":null,"uri":"http://192.168.1.168:10246/MDEServer/4C7263B5-F275-4603-AC8A-42E3205E1DE4/1000.wav","trackType":"wav"} Mar 30 13:27:21 volumio volumio[7872]: verbose: CURRENT POSITION 0 Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState stateService play Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::syncState currentStatus play Mar 30 13:27:21 volumio volumio[7872]: info: Received an update from plugin. extracting info from payload Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreStateMachine::pushState Mar 30 13:27:21 volumio volumio[7872]: info: CoreCommandRouter::volumioPushState Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 31ms Mar 30 13:27:21 volumio volumio[7872]: info: ------------------------------ 32ms Mar 30 13:27:34 volumio volumio[7872]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 13:27:34 volumio volumio[7872]: Error: connect ETIMEDOUT 202.160.128.238:443 Mar 30 13:27:34 volumio volumio[7872]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 30 13:27:34 volumio volumio[7872]: errno: -110, Mar 30 13:27:34 volumio volumio[7872]: code: 'ETIMEDOUT', Mar 30 13:27:34 volumio volumio[7872]: syscall: 'connect', Mar 30 13:27:34 volumio volumio[7872]: address: '202.160.128.238', Mar 30 13:27:34 volumio volumio[7872]: port: 443 Mar 30 13:27:34 volumio volumio[7872]: } Mar 30 13:27:34 volumio volumio[7872]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 13:27:35 volumio sudo[11051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 13:26 Mar 30 13:27:35 volumio sudo[11051]: 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="9552505bba4239c163ac9ee7b0b87a56e0dd0574" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 07:28:53 PM CET" VOLUMIO_VERSION="3.616" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f11d51aa83fa91106999927181e8c0f7"