-- Logs begin at Fri 2024-09-06 23:47:30 CST, end at Fri 2024-09-06 23:53:24 CST. -- Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:11 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:11 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:11 volumio volumio[1086]: info: sendMpdCommand status took 4 milliseconds Sep 06 23:52:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: 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":"天空没有极限 (cover: G.E.M. 邓紫棋)","artist":"咻咻满","album":"2024流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800000mzntW0YOPDp.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=605DB9A096EA09D95D063E580D5604F99E7497A15250CA373DE3729C3BCD880C688F59A23D038F62A216DB2792438E21AFBD3B118FB2D8B6&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::play index undefined Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: 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":"天空没有极限 (cover: G.E.M. 邓紫棋)","artist":"咻咻满","album":"2024流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800000mzntW0YOPDp.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=605DB9A096EA09D95D063E580D5604F99E7497A15250CA373DE3729C3BCD880C688F59A23D038F62A216DB2792438E21AFBD3B118FB2D8B6&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: No code Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 35ms Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 34ms Sep 06 23:52:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 29 milliseconds Sep 06 23:52:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: 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":"天空没有极限 (cover: G.E.M. 邓紫棋)","artist":"咻咻满","album":"2024流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800000mzntW0YOPDp.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=605DB9A096EA09D95D063E580D5604F99E7497A15250CA373DE3729C3BCD880C688F59A23D038F62A216DB2792438E21AFBD3B118FB2D8B6&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: No code Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 52ms Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:11 volumio volumio[1086]: info: Clearing queue after UPNP request Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::ClearQueue Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::stop Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::clearPlayQueue Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::saveQueue Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushQueue Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:11 volumio volumio[1086]: info: Sep 06 23:52:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:11 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:11 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:11 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:11 volumio volumio[1086]: info: Starting UPNP Playback Sep 06 23:52:11 volumio volumio[1086]: info: Preparing playback through UPNP Sep 06 23:52:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetState Sep 06 23:52:11 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:11 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 9ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 9ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 8ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 232 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 231 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 232 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:12 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 243ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 248ms Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:12 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:12 volumio volumio[1086]: info: Sep 06 23:52:12 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 19 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 19 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 5ms Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 4 milliseconds Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:12 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":432,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:12 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 284ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 54ms Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 39 milliseconds Sep 06 23:52:12 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:12 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:12 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:12 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"句号","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:12 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:12 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 74ms Sep 06 23:52:12 volumio volumio[1086]: info: ------------------------------ 73ms Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:27 volumio volumio[1086]: info: Sep 06 23:52:27 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:27 volumio volumio[1086]: info: Sep 06 23:52:27 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:27 volumio volumio[1086]: info: Sep 06 23:52:27 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: 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":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:27 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::play index undefined Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: 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":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:27 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: No code Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: ------------------------------ 33ms Sep 06 23:52:27 volumio volumio[1086]: info: ------------------------------ 33ms Sep 06 23:52:27 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 30 milliseconds Sep 06 23:52:27 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:27 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: 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":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800001COidC4Bqrkf.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=965790673C13482E90BB4D1F5A15CF55B5DBB5E948D2667B01DC5CFE2050BEF1AA96EFEA85970E4ACF5A41759816EF4E662CDEADC6815FC8&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:27 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: No code Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:27 volumio volumio[1086]: info: ------------------------------ 51ms Sep 06 23:52:27 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:27 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:27 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:27 volumio volumio[1086]: info: Clearing queue after UPNP request Sep 06 23:52:28 volumio volumio[1086]: info: CoreStateMachine::ClearQueue Sep 06 23:52:28 volumio volumio[1086]: info: CoreStateMachine::stop Sep 06 23:52:28 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:28 volumio volumio[1086]: info: CorePlayQueue::clearPlayQueue Sep 06 23:52:28 volumio volumio[1086]: info: CorePlayQueue::saveQueue Sep 06 23:52:28 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:28 volumio volumio[1086]: info: CoreCommandRouter::volumioPushQueue Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:28 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:28 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:28 volumio volumio[1086]: info: Starting UPNP Playback Sep 06 23:52:28 volumio volumio[1086]: info: Preparing playback through UPNP Sep 06 23:52:28 volumio volumio[1086]: info: CoreCommandRouter::volumioGetState Sep 06 23:52:28 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:28 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:28 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:28 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:28 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:28 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:28 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:28 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:28 volumio volumio[1086]: info: Sep 06 23:52:28 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:28 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:28 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:29 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 232 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 233 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 232 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 238ms Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:29 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:29 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:29 volumio volumio[1086]: info: Sep 06 23:52:29 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:29 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:29 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:29 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 287ms Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 287ms Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 56ms Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 47 milliseconds Sep 06 23:52:29 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 47 milliseconds Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:29 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:29 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:29 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:29 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:29 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 90ms Sep 06 23:52:29 volumio volumio[1086]: info: ------------------------------ 90ms Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:29 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:29 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: Sep 06 23:52:30 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:30 volumio volumio[1086]: info: Sep 06 23:52:30 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:30 volumio volumio[1086]: info: Sep 06 23:52:30 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:30 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:30 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":306000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:30 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:30 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:30 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:30 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":306000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:30 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:30 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: ------------------------------ 35ms Sep 06 23:52:30 volumio volumio[1086]: info: ------------------------------ 35ms Sep 06 23:52:30 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 31 milliseconds Sep 06 23:52:30 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:30 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:30 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:30 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":306000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:30 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:30 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:30 volumio volumio[1086]: info: ------------------------------ 49ms Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:30 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:30 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: Sep 06 23:52:33 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:33 volumio volumio[1086]: info: Sep 06 23:52:33 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:33 volumio volumio[1086]: info: Sep 06 23:52:33 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:33 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:33 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":327000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:33 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:33 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:33 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:33 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":327000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:33 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:33 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: ------------------------------ 30ms Sep 06 23:52:33 volumio volumio[1086]: info: ------------------------------ 30ms Sep 06 23:52:33 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 06 23:52:33 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:33 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:33 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:33 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":327000,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"连名带姓","artist":"张惠妹","album":"偷故事的人","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:33 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:33 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:33 volumio volumio[1086]: info: ------------------------------ 43ms Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:33 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:33 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:38 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:38 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:38 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:38 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:38 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:38 volumio volumio[1086]: info: Sep 06 23:52:38 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:38 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:38 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:52:38 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:38 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:38 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:38 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:38 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:38 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:38 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:38 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:38 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:38 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:38 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":333238,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Á¬Ãû´øÐÕ","artist":"ÕÅ»ÝÃÃ","album":"͵¹ÊʵÄÈË","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:38 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:38 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:38 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:38 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:38 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:38 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:38 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:38 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:38 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:38 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":333238,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Á¬Ãû´øÐÕ","artist":"ÕÅ»ÝÃÃ","album":"͵¹ÊʵÄÈË","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:39 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:39 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:39 volumio volumio[1086]: info: ------------------------------ 32ms Sep 06 23:52:39 volumio volumio[1086]: info: ------------------------------ 32ms Sep 06 23:52:39 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 28 milliseconds Sep 06 23:52:39 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:39 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:39 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:39 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":333238,"duration":334,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Á¬Ãû´øÐÕ","artist":"ÕÅ»ÝÃÃ","album":"͵¹ÊʵÄÈË","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002hqtan0tJnDv.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=02BA90B8B1B57456101E868BCAB4329FEE93D1928F95298C31DC470478C0B0565458D742DED5A2C43BF81D8479177CCC09CAD729D8DECC72&uin=1152921504965316901&src=M800002ZqDLe2jik1v.mp3&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:39 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:39 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:39 volumio volumio[1086]: info: ------------------------------ 46ms Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:39 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:39 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:40 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:52:40 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:52:40 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::play index undefined Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:52:40 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: No code Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 28ms Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 28ms Sep 06 23:52:40 volumio volumio[1086]: info: sendMpdCommand status took 28 milliseconds Sep 06 23:52:40 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:40 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:52:40 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: No code Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 49ms Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:40 volumio volumio[1086]: info: Clearing queue after UPNP request Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::ClearQueue Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::stop Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::clearPlayQueue Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::saveQueue Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioPushQueue Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:40 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:40 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:40 volumio volumio[1086]: info: Sep 06 23:52:40 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:40 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:40 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:40 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:40 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:52:40 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:40 volumio volumio[1086]: info: Starting UPNP Playback Sep 06 23:52:40 volumio volumio[1086]: info: Preparing playback through UPNP Sep 06 23:52:40 volumio volumio[1086]: info: CoreCommandRouter::volumioGetState Sep 06 23:52:40 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:52:40 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 1ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 233 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 234 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 233 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 239ms Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:52:41 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:52:41 volumio volumio[1086]: info: Sep 06 23:52:41 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":717,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:41 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:41 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:41 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 275ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 274ms Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 44ms Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand status took 38 milliseconds Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 36 milliseconds Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:41 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 54ms Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 06 23:52:41 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:41 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:41 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:41 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:41 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:41 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:41 volumio volumio[1086]: info: ------------------------------ 79ms Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:41 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:41 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: Sep 06 23:52:45 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:45 volumio volumio[1086]: info: Sep 06 23:52:45 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:45 volumio volumio[1086]: info: Sep 06 23:52:45 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand status took 3 milliseconds Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand status took 6 milliseconds Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand status took 5 milliseconds Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:45 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:45 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":262000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:45 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:45 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: ------------------------------ 21ms Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 06 23:52:45 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:45 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:45 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:45 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":262000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:45 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:45 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:52:45 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:52:45 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":262000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"笼 (cover: 张碧晨)","artist":"咻咻满","album":"2023流行歌曲精选","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:52:45 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:52:45 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:52:45 volumio volumio[1086]: info: ------------------------------ 44ms Sep 06 23:52:45 volumio volumio[1086]: info: ------------------------------ 44ms Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:52:45 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:52:45 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:02 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:02 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:02 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:02 volumio volumio[1086]: info: Sep 06 23:53:02 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand status took 4 milliseconds Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand status took 5 milliseconds Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:02 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:02 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":279985,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Áý (cover: Õű̳¿)","artist":"ßÝßÝÂú","album":"2023Á÷ÐиèÇú¾«Ñ¡","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:02 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:02 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:02 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:02 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":279985,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Áý (cover: Õű̳¿)","artist":"ßÝßÝÂú","album":"2023Á÷ÐиèÇú¾«Ñ¡","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:02 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:02 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 37ms Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 37ms Sep 06 23:53:02 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 30 milliseconds Sep 06 23:53:02 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:02 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:02 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:02 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":279985,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Áý (cover: Õű̳¿)","artist":"ßÝßÝÂú","album":"2023Á÷ÐиèÇú¾«Ñ¡","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800003T155c49mq8y.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=EF15A0E1B14CB82E5C323C38EAE17B6E4F0622C5B48B420534E35DBFCA1F49EE986550BE34A75958CB46F9A475F35AB752B5EB89394EBB29&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:02 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:02 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:02 volumio volumio[1086]: info: ------------------------------ 51ms Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:02 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:02 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:04 volumio volumio[1086]: info: Sep 06 23:53:04 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:04 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:04 volumio volumio[1086]: info: Sep 06 23:53:04 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:04 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:04 volumio volumio[1086]: info: Sep 06 23:53:04 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:04 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:04 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:53:04 volumio volumio[1086]: info: sendMpdCommand status took 2 milliseconds Sep 06 23:53:04 volumio volumio[1086]: info: sendMpdCommand status took 1 milliseconds Sep 06 23:53:04 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:04 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:53:04 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::play index undefined Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:53:04 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: No code Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 06 23:53:04 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState stateService stop Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: No code Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:04 volumio volumio[1086]: info: ------------------------------ 60ms Sep 06 23:53:04 volumio volumio[1086]: info: ------------------------------ 60ms Sep 06 23:53:04 volumio volumio[1086]: info: ------------------------------ 60ms Sep 06 23:53:04 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:04 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:04 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:10 volumio volumio[1086]: info: Clearing queue after UPNP request Sep 06 23:53:10 volumio volumio[1086]: info: CoreStateMachine::ClearQueue Sep 06 23:53:10 volumio volumio[1086]: info: CoreStateMachine::stop Sep 06 23:53:10 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 23:53:10 volumio volumio[1086]: info: CorePlayQueue::clearPlayQueue Sep 06 23:53:10 volumio volumio[1086]: info: CorePlayQueue::saveQueue Sep 06 23:53:10 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:10 volumio volumio[1086]: info: CoreCommandRouter::volumioPushQueue Sep 06 23:53:10 volumio volumio[1086]: info: Sep 06 23:53:10 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:10 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:10 volumio volumio[1086]: info: Sep 06 23:53:10 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:10 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:10 volumio volumio[1086]: info: Sep 06 23:53:10 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:10 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:10 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:53:10 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:53:10 volumio volumio[1086]: error: updateQueue error: null Sep 06 23:53:10 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:10 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:10 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:10 volumio volumio[1086]: info: Starting UPNP Playback Sep 06 23:53:10 volumio volumio[1086]: info: Preparing playback through UPNP Sep 06 23:53:10 volumio volumio[1086]: info: CoreCommandRouter::volumioGetState Sep 06 23:53:10 volumio volumio[1086]: info: CorePlayQueue::getTrack 0 Sep 06 23:53:10 volumio volumio[1086]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 3ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 2ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 232 milliseconds Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 235 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 234 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus stop Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 239ms Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces system playlist update Sep 06 23:53:11 volumio volumio[1086]: info: Ignoring MPD Status Update Sep 06 23:53:11 volumio volumio[1086]: info: Sep 06 23:53:11 volumio volumio[1086]: ---------------------------- MPD announces state update: player Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::getState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand status Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 8ms Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 7 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 4 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 4ms Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":717,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:11 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:11 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 279ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 279ms Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand status took 43 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 40 milliseconds Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 39 milliseconds Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseState Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:11 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:11 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 94ms Sep 06 23:53:11 volumio volumio[1086]: info: ------------------------------ 91ms Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:11 volumio volumio[1086]: info: sendMpdCommand playlistinfo took 60 milliseconds Sep 06 23:53:11 volumio volumio[1086]: verbose: ControllerMpd::parseTrackInfo Sep 06 23:53:11 volumio volumio[1086]: info: ControllerMpd::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::servicePushState Sep 06 23:53:11 volumio volumio[1086]: verbose: In UPNP mode Sep 06 23:53:11 volumio volumio[1086]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"無能","artist":"Österreich","album":"無能","uri":"http://116.153.3.21/amobile.music.tc.qq.com/M800002qVFPj40ZGRk.mp3?guid=00000000385a3bc70000018fcdbfef9f&vkey=D97D0B8BC0346FD10CE4F702435A6A7201E86CE9363B0F5B86178CC53E1BA86EA3C61D07361B5A3E706B2801234B33F995C07785E570F54C&uin=1152921504965316901&redirect=1&fromtag=111093","trackType":""} Sep 06 23:53:11 volumio volumio[1086]: verbose: CURRENT POSITION 0 Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState stateService play Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::syncState currentStatus play Sep 06 23:53:11 volumio volumio[1086]: info: Received an update from plugin. extracting info from payload Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreStateMachine::pushState Sep 06 23:53:11 volumio volumio[1086]: info: CoreCommandRouter::volumioPushState Sep 06 23:53:12 volumio volumio[1086]: info: ------------------------------ 124ms Sep 06 23:53:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:12 volumio volumio[1086]: info: CoreCommandRouter::volumioGetQueue Sep 06 23:53:12 volumio volumio[1086]: info: CoreStateMachine::getQueue Sep 06 23:53:12 volumio volumio[1086]: info: CorePlayQueue::getQueue Sep 06 23:53:23 volumio volumio[1086]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 23:53:23 volumio volumio[1086]: Error: connect ETIMEDOUT 116.89.243.8:443 Sep 06 23:53:23 volumio volumio[1086]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 06 23:53:23 volumio volumio[1086]: errno: -110, Sep 06 23:53:23 volumio volumio[1086]: code: 'ETIMEDOUT', Sep 06 23:53:23 volumio volumio[1086]: syscall: 'connect', Sep 06 23:53:23 volumio volumio[1086]: address: '116.89.243.8', Sep 06 23:53:23 volumio volumio[1086]: port: 443 Sep 06 23:53:23 volumio volumio[1086]: } Sep 06 23:53:23 volumio volumio[1086]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 23:53:24 volumio sudo[3053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 23:52 Sep 06 23:53:24 volumio sudo[3053]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"