-- Logs begin at Wed 2026-06-03 01:34:03 UTC, end at Wed 2026-06-03 03:17:35 UTC. -- Jun 03 03:16:33 volumio volumio[18587]: info: Jun 03 03:16:33 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:33 volumio volumio[18587]: info: Jun 03 03:16:33 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:33 volumio volumio[18587]: info: Jun 03 03:16:33 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand status took 3 milliseconds Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 03:16:33 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:33 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Predator","artist":"WYR GEMI","album":"Predator","uri":"http://fsandroid.tx.kugou.com/202606031115/71537e580a1e430edb2963a552fb3e90/v3/10a68c6d2ede3ee10f4455c4dd49e874/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx258009266_quflac_pa596772835_ct532500_s283160393.flac","trackType":"flac"} Jun 03 03:16:33 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::play index undefined Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Predator","artist":"WYR GEMI","album":"Predator","uri":"http://fsandroid.tx.kugou.com/202606031115/71537e580a1e430edb2963a552fb3e90/v3/10a68c6d2ede3ee10f4455c4dd49e874/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx258009266_quflac_pa596772835_ct532500_s283160393.flac","trackType":"flac"} Jun 03 03:16:33 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: No code Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Predator","artist":"WYR GEMI","album":"Predator","uri":"http://fsandroid.tx.kugou.com/202606031115/71537e580a1e430edb2963a552fb3e90/v3/10a68c6d2ede3ee10f4455c4dd49e874/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx258009266_quflac_pa596772835_ct532500_s283160393.flac","trackType":"flac"} Jun 03 03:16:33 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: No code Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:33 volumio volumio[18587]: info: ------------------------------ 66ms Jun 03 03:16:33 volumio volumio[18587]: info: ------------------------------ 65ms Jun 03 03:16:33 volumio volumio[18587]: info: ------------------------------ 63ms Jun 03 03:16:33 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:33 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:33 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:34 volumio volumio[18587]: info: Clearing queue after UPNP request Jun 03 03:16:34 volumio volumio[18587]: info: CoreStateMachine::ClearQueue Jun 03 03:16:34 volumio volumio[18587]: info: CoreStateMachine::stop Jun 03 03:16:34 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:34 volumio volumio[18587]: info: CorePlayQueue::clearPlayQueue Jun 03 03:16:34 volumio volumio[18587]: info: CorePlayQueue::saveQueue Jun 03 03:16:34 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:34 volumio volumio[18587]: info: CoreCommandRouter::volumioPushQueue Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:35 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:35 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: Starting UPNP Playback Jun 03 03:16:35 volumio volumio[18587]: info: Preparing playback through UPNP Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetState Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 6 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 24ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 52ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 52ms Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 46 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 45 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 45ms Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 44 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"798 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 66ms Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:35 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:35 volumio volumio[18587]: info: Jun 03 03:16:35 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 31 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 13ms Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 13 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 13ms Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand status took 12 milliseconds Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"798 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"798 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"798 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 117ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 116ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 117ms Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 36 milliseconds Jun 03 03:16:35 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 37 milliseconds Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"781 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:35 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:35 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":162,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"781 Kbps","isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:35 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:35 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 77ms Jun 03 03:16:35 volumio volumio[18587]: info: ------------------------------ 77ms Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:35 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:35 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:38 volumio volumio[18587]: info: Jun 03 03:16:38 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:38 volumio volumio[18587]: info: Jun 03 03:16:38 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:38 volumio volumio[18587]: info: Jun 03 03:16:38 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:38 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:38 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:38 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:38 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::play index undefined Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: ------------------------------ 18ms Jun 03 03:16:38 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:38 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:38 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: No code Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"纯音乐无言的温柔","artist":"李图云","album":"无言的温柔","uri":"http://fsandroid.tx.kugou.com/202606031116/c940fce6bc0973c5a419525aaa694a59/v3/10ad02800d066ec3e9347bdc479590ab/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx339910828_quflac_pa596772835_ct532500_s3328248716.flac","trackType":"flac"} Jun 03 03:16:38 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: No code Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:38 volumio volumio[18587]: info: ------------------------------ 47ms Jun 03 03:16:38 volumio volumio[18587]: info: ------------------------------ 47ms Jun 03 03:16:38 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:38 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:38 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:39 volumio volumio[18587]: info: Clearing queue after UPNP request Jun 03 03:16:39 volumio volumio[18587]: info: CoreStateMachine::ClearQueue Jun 03 03:16:39 volumio volumio[18587]: info: CoreStateMachine::stop Jun 03 03:16:39 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:39 volumio volumio[18587]: info: CorePlayQueue::clearPlayQueue Jun 03 03:16:39 volumio volumio[18587]: info: CorePlayQueue::saveQueue Jun 03 03:16:39 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:39 volumio volumio[18587]: info: CoreCommandRouter::volumioPushQueue Jun 03 03:16:39 volumio volumio[18587]: info: Jun 03 03:16:39 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:39 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:39 volumio volumio[18587]: info: Jun 03 03:16:39 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:39 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:39 volumio volumio[18587]: info: Jun 03 03:16:39 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:39 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:39 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:39 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:39 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:39 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:39 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:39 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:39 volumio volumio[18587]: info: Starting UPNP Playback Jun 03 03:16:39 volumio volumio[18587]: info: Preparing playback through UPNP Jun 03 03:16:39 volumio volumio[18587]: info: CoreCommandRouter::volumioGetState Jun 03 03:16:39 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:39 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 5 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 5 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 5 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"İskorbeatz、EL Records - Angetenar","artist":"İskorbeatz、EL Records","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 16ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 3 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"İskorbeatz、EL Records - Angetenar","artist":"İskorbeatz、EL Records","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"İskorbeatz、EL Records - Angetenar","artist":"İskorbeatz、EL Records","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"İskorbeatz、EL Records - Angetenar","artist":"İskorbeatz、EL Records","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"İskorbeatz、EL Records - Angetenar","artist":"İskorbeatz、EL Records","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 57ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 56ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 55ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 54ms Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:40 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:40 volumio volumio[18587]: info: Jun 03 03:16:40 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 45ms Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 44 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"984 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 67ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 37ms Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 37 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 37ms Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand status took 36 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 35 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 101ms Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 03 03:16:40 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:40 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:40 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:40 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:40 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:40 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 75ms Jun 03 03:16:40 volumio volumio[18587]: info: ------------------------------ 75ms Jun 03 03:16:42 volumio volumio[18587]: info: Jun 03 03:16:42 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:42 volumio volumio[18587]: info: Jun 03 03:16:42 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:42 volumio volumio[18587]: info: Jun 03 03:16:42 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:42 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:42 volumio volumio[18587]: info: sendMpdCommand status took 0 milliseconds Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:42 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:42 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::play index undefined Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: ------------------------------ 14ms Jun 03 03:16:42 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 03 03:16:42 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:42 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:42 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: No code Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/270cf806aaeea745061c37feb6e0f242/v3/108cc0de83d8f98ba40aed143646c989/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx664024556_quflac_pa596772835_ct532500_s212863092.flac","trackType":"flac"} Jun 03 03:16:42 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: No code Jun 03 03:16:42 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:42 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:42 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:42 volumio volumio[18587]: info: ------------------------------ 39ms Jun 03 03:16:42 volumio volumio[18587]: info: ------------------------------ 40ms Jun 03 03:16:43 volumio volumio[18587]: info: Clearing queue after UPNP request Jun 03 03:16:43 volumio volumio[18587]: info: CoreStateMachine::ClearQueue Jun 03 03:16:43 volumio volumio[18587]: info: CoreStateMachine::stop Jun 03 03:16:43 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:43 volumio volumio[18587]: info: CorePlayQueue::clearPlayQueue Jun 03 03:16:43 volumio volumio[18587]: info: CorePlayQueue::saveQueue Jun 03 03:16:43 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:43 volumio volumio[18587]: info: CoreCommandRouter::volumioPushQueue Jun 03 03:16:43 volumio volumio[18587]: info: Jun 03 03:16:43 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:43 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:43 volumio volumio[18587]: info: Jun 03 03:16:43 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:43 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:43 volumio volumio[18587]: info: Jun 03 03:16:43 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:43 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:43 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:43 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:43 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:43 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:43 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:43 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:43 volumio volumio[18587]: info: Starting UPNP Playback Jun 03 03:16:43 volumio volumio[18587]: info: Preparing playback through UPNP Jun 03 03:16:43 volumio volumio[18587]: info: CoreCommandRouter::volumioGetState Jun 03 03:16:43 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:43 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 4ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: Jun 03 03:16:44 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:44 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:44 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 20ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 36ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 36ms Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 31 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 31 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Argy - Tataki","artist":"Argy","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 77ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 76ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 75ms Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:47 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:47 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:47 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:47 volumio volumio[18587]: info: Jun 03 03:16:47 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 9ms Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 5 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:47 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:47 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:47 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:47 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:47 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 40ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 36ms Jun 03 03:16:47 volumio volumio[18587]: info: ------------------------------ 35ms Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:47 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:47 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:51 volumio volumio[18587]: info: Jun 03 03:16:51 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:51 volumio volumio[18587]: info: Jun 03 03:16:51 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:51 volumio volumio[18587]: info: Jun 03 03:16:51 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:51 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:51 volumio volumio[18587]: info: sendMpdCommand status took 1 milliseconds Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:51 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 03:16:51 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:51 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:51 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::play index undefined Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:51 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: No code Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tataki","artist":"Argy","album":"Tataki","uri":"http://fsandroid.tx.kugou.com/202606031116/c072f05c9406773d36b9324c897ee109/v3/c77ce2e70a93eb348740e6ca8dacff9e/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx359544950_quflac_pa596772835_ct532500_s3234726683.flac","trackType":"flac"} Jun 03 03:16:51 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState stateService stop Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: No code Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:51 volumio volumio[18587]: info: ------------------------------ 33ms Jun 03 03:16:51 volumio volumio[18587]: info: ------------------------------ 32ms Jun 03 03:16:51 volumio volumio[18587]: info: ------------------------------ 34ms Jun 03 03:16:51 volumio volumio[18587]: info: CoreCommandRouter::volumioGetQueue Jun 03 03:16:51 volumio volumio[18587]: info: CoreStateMachine::getQueue Jun 03 03:16:51 volumio volumio[18587]: info: CorePlayQueue::getQueue Jun 03 03:16:52 volumio volumio[18587]: info: Clearing queue after UPNP request Jun 03 03:16:52 volumio volumio[18587]: info: CoreStateMachine::ClearQueue Jun 03 03:16:52 volumio volumio[18587]: info: CoreStateMachine::stop Jun 03 03:16:52 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 03:16:52 volumio volumio[18587]: info: CorePlayQueue::clearPlayQueue Jun 03 03:16:52 volumio volumio[18587]: info: CorePlayQueue::saveQueue Jun 03 03:16:52 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:52 volumio volumio[18587]: info: CoreCommandRouter::volumioPushQueue Jun 03 03:16:52 volumio volumio[18587]: info: Jun 03 03:16:52 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:52 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:52 volumio volumio[18587]: info: Jun 03 03:16:52 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:52 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:52 volumio volumio[18587]: info: Jun 03 03:16:52 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:52 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:52 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:52 volumio volumio[18587]: error: updateQueue error: null Jun 03 03:16:52 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:52 volumio volumio[18587]: info: Starting UPNP Playback Jun 03 03:16:52 volumio volumio[18587]: info: Preparing playback through UPNP Jun 03 03:16:52 volumio volumio[18587]: info: CoreCommandRouter::volumioGetState Jun 03 03:16:52 volumio volumio[18587]: info: CorePlayQueue::getTrack 0 Jun 03 03:16:52 volumio volumio[18587]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 3ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 1ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 5ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 5ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 2ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 3 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 2 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus stop Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 16ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 30ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 30ms Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 25 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 25 milliseconds Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 39ms Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vorx - WHAT?","artist":"Vorx","album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 67ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 67ms Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces system playlist update Jun 03 03:16:53 volumio volumio[18587]: info: Ignoring MPD Status Update Jun 03 03:16:53 volumio volumio[18587]: info: Jun 03 03:16:53 volumio volumio[18587]: ---------------------------- MPD announces state update: player Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::getState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand status Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 11ms Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 11 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 9ms Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 3 milliseconds Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 4ms Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand status took 4 milliseconds Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseState Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 03:16:53 volumio volumio[18587]: info: sendMpdCommand playlistinfo took 75 milliseconds Jun 03 03:16:53 volumio volumio[18587]: verbose: ControllerMpd::parseTrackInfo Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ControllerMpd::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::servicePushState Jun 03 03:16:53 volumio volumio[18587]: verbose: In UPNP mode Jun 03 03:16:53 volumio volumio[18587]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":277,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","artist":null,"album":null,"uri":"http://fsandroid.tx.kugou.com/202606031116/bde1cdc701b0b84e93e5c209dd1da0cf/v3/da315bbee28f0746d599fd5986e984e1/yp/full/ap1005_us1070578799_df4wyxur0xswdm1hvhwz3mnv9m_pi2_mx340803044_qu320_pa596772835_ct532500_s4227195625.mp3","trackType":"mp3"} Jun 03 03:16:53 volumio volumio[18587]: verbose: CURRENT POSITION 0 Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState stateService play Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::syncState currentStatus play Jun 03 03:16:53 volumio volumio[18587]: info: Received an update from plugin. extracting info from payload Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreStateMachine::pushState Jun 03 03:16:53 volumio volumio[18587]: info: CoreCommandRouter::volumioPushState Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 124ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 117ms Jun 03 03:16:53 volumio volumio[18587]: info: ------------------------------ 117ms Jun 03 03:17:35 volumio volumio[18587]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 03:17:35 volumio volumio[18587]: Error: connect ETIMEDOUT 31.13.95.38:443 Jun 03 03:17:35 volumio volumio[18587]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 03 03:17:35 volumio volumio[18587]: errno: -110, Jun 03 03:17:35 volumio volumio[18587]: code: 'ETIMEDOUT', Jun 03 03:17:35 volumio volumio[18587]: syscall: 'connect', Jun 03 03:17:35 volumio volumio[18587]: address: '31.13.95.38', Jun 03 03:17:35 volumio volumio[18587]: port: 443 Jun 03 03:17:35 volumio volumio[18587]: } Jun 03 03:17:35 volumio volumio[18587]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 03:17:35 volumio sudo[22662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-03 03:16 Jun 03 03:17:35 volumio sudo[22662]: 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="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 09:58:18 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="54b3518c7dd8feba4753e0ad124ce801"