-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2025-01-15 19:33:23 CST. -- Jan 15 19:32:10 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:32:11 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:32:11 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:11 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:11 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:32:11 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:32:11 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:11 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: Jan 15 19:32:11 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:11 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:11 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 19ms Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 32ms Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 31ms Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 25 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1 (아일리원)","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 55ms Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 53ms Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 54ms Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:12 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:12 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:12 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:12 volumio-1 volumio[901]: info: Jan 15 19:32:12 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 7ms Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 6 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 5ms Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 4ms Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand status took 5 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1891 Kbps","isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1891 Kbps","isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 30ms Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 27ms Jan 15 19:32:12 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 15 19:32:12 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:12 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:12 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1962 Kbps","isStreaming":false,"title":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:12 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:12 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:12 volumio-1 volumio[901]: info: ------------------------------ 38ms Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:12 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:23 volumio-1 volumio[901]: info: Jan 15 19:32:23 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:23 volumio-1 volumio[901]: info: Jan 15 19:32:23 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:23 volumio-1 volumio[901]: info: Jan 15 19:32:23 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:23 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:23 volumio-1 volumio[901]: 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":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:23 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::stPlaybackTimer Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:23 volumio-1 volumio[901]: 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":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:23 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: No code Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:23 volumio-1 volumio[901]: 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":"I MY ME MINE","artist":"ILY:1","album":"IMMM","uri":"http://aqqmusic.tc.qq.com/F000002toiYu03ZgPH.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E7CECD3A59FE6134253FA1D254AC64B8FD5F9BC4FB6F9A662EC1956647EEDFA345563943124223EC9F24236382F9D478577EF8CC392BABB5__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:23 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: No code Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:23 volumio-1 volumio[901]: info: ------------------------------ 36ms Jan 15 19:32:23 volumio-1 volumio[901]: info: ------------------------------ 36ms Jan 15 19:32:23 volumio-1 volumio[901]: info: ------------------------------ 36ms Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:23 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:23 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:24 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:32:24 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:32:24 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:24 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:24 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:32:24 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:32:24 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:24 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:24 volumio-1 volumio[901]: info: Jan 15 19:32:24 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 6 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 5 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:24 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:24 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你 (国粤语版)","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:24 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:24 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:24 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:24 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你 (国粤语版)","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:24 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:24 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:24 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:24 volumio-1 volumio[901]: info: ------------------------------ 18ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 21ms Jan 15 19:32:25 volumio-1 volumio[901]: info: Jan 15 19:32:25 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:25 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:25 volumio-1 volumio[901]: info: Jan 15 19:32:25 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:25 volumio-1 volumio[901]: info: Jan 15 19:32:25 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:25 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:25 volumio-1 volumio[901]: info: Jan 15 19:32:25 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 16ms Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand status took 16 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"425 Kbps","isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"392 Kbps","isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 65ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 64ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 63ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 61ms Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 51 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"392 Kbps","isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"380 Kbps","isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:25 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:25 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"380 Kbps","isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:25 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:25 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 99ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 86ms Jan 15 19:32:25 volumio-1 volumio[901]: info: ------------------------------ 85ms Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:25 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:33 volumio-1 volumio[901]: info: Jan 15 19:32:33 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:33 volumio-1 volumio[901]: info: Jan 15 19:32:33 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:33 volumio-1 volumio[901]: info: Jan 15 19:32:33 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:33 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:33 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:33 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::stPlaybackTimer Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:33 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:33 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: No code Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:33 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"留什么给你","artist":"车厘子的车车","album":"留什么给你(国粤语版)","uri":"http://aqqmusic.tc.qq.com/F0000024wxqK1VN1A7.flac?guid=00000000220dc7310000018e057bcdd7&vkey=B6EBEB33A0F8A782F23FD0ECD0B6E3258F464AEF784B1D89DC3E8242EB0043FC7F52BF56B463E5085A2701291201D1983F821D5112861F2F__v21e2a16ad&uin=335238641&src=F0000042CNL043Hhnb.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:33 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: No code Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:33 volumio-1 volumio[901]: info: ------------------------------ 37ms Jan 15 19:32:33 volumio-1 volumio[901]: info: ------------------------------ 36ms Jan 15 19:32:33 volumio-1 volumio[901]: info: ------------------------------ 36ms Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:33 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:33 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:33 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:34 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:34 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:32:34 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 0ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 17ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 26ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 26ms Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 51ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 49ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 48ms Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:34 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:34 volumio-1 volumio[901]: info: Jan 15 19:32:34 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 5ms Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 4ms Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"993 Kbps","isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"787 Kbps","isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:34 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:34 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":231,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"633 Kbps","isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:34 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:34 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 41ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 39ms Jan 15 19:32:34 volumio-1 volumio[901]: info: ------------------------------ 39ms Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:34 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:55 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:55 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:55 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::stPlaybackTimer Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:55 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:55 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: No code Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:55 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"野孩子","artist":"一杯陈豆浆","album":"野孩子","uri":"http://aqqmusic.tc.qq.com/F000000ACuQX0VLU1j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=4E1F1C39ADB2716D85037749D6B5E69AEA058A902234FDC0955A3F9CD2CF88FAE76136861BAC995C98D89AE8B049C94C4977FABC0699F448__v2b9aacfc&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:55 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: No code Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 39ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 39ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 38ms Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:55 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:55 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:32:55 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:32:55 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:55 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 4ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: Jan 15 19:32:55 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:55 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:55 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:56 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:56 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:56 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: No code Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:56 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:56 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: No code Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:56 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:56 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: No code Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 54ms Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 55ms Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 54ms Jan 15 19:32:56 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:56 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:56 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:56 volumio-1 volumio[901]: info: Jan 15 19:32:56 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:56 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:56 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:56 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:56 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:56 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:56 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:32:56 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:32:56 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:32:56 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 5ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 17ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 29ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 29ms Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 53ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 52ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 52ms Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:32:57 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:32:57 volumio-1 volumio[901]: info: Jan 15 19:32:57 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 38ms Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 38 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"399 Kbps","isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"397 Kbps","isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:32:57 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:32:57 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"397 Kbps","isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:32:57 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:32:57 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 64ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 29ms Jan 15 19:32:57 volumio-1 volumio[901]: info: ------------------------------ 29ms Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:32:57 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:04 volumio-1 volumio[901]: info: Jan 15 19:33:04 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:04 volumio-1 volumio[901]: info: Jan 15 19:33:04 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:04 volumio-1 volumio[901]: info: Jan 15 19:33:04 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:04 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:33:04 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:04 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::stPlaybackTimer Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:33:04 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:04 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: No code Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:33:04 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"青春无悔","artist":"汤宝如","album":"青春无悔","uri":"http://aqqmusic.tc.qq.com/F000000TGeWj0w5Z0j.flac?guid=00000000220dc7310000018e057bcdd7&vkey=AF7925FAA0F60BE9D9DCCA1AAE0D448EF9EC8F47475AD33DD5AF70EF603A1E11645E84B9A81CF9F3171D1B9DC2E97E663806310E28469E8F__v21e2a186f&uin=335238641&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:04 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService stop Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: No code Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:04 volumio-1 volumio[901]: info: ------------------------------ 45ms Jan 15 19:33:04 volumio-1 volumio[901]: info: ------------------------------ 44ms Jan 15 19:33:04 volumio-1 volumio[901]: info: ------------------------------ 45ms Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:04 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:04 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:04 volumio-1 volumio[901]: info: Clearing queue after UPNP request Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::ClearQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::stop Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::clearPlayQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::saveQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:33:05 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:33:05 volumio-1 volumio[901]: error: updateQueue error: null Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Starting UPNP Playback Jan 15 19:33:05 volumio-1 volumio[901]: info: Preparing playback through UPNP Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetState Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getTrack 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 1ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 5 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 3 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 14ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 20ms Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"APT.","artist":"ROSÉ (로제)/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 52ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 51ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 50ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 49ms Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces system playlist update Jan 15 19:33:05 volumio-1 volumio[901]: info: Ignoring MPD Status Update Jan 15 19:33:05 volumio-1 volumio[901]: info: Jan 15 19:33:05 volumio-1 volumio[901]: ---------------------------- MPD announces state update: player Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::getState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 4ms Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 4 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 3ms Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 2 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 2ms Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand status took 1 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"APT.","artist":"Rosé/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"APT.","artist":"Rosé/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ControllerMpd::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::servicePushState Jan 15 19:33:05 volumio-1 volumio[901]: verbose: In UPNP mode Jan 15 19:33:05 volumio-1 volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"767 Kbps","isStreaming":false,"title":"APT.","artist":"Rosé/Bruno Mars","album":"APT.","uri":"http://aqqmusic.tc.qq.com/F000000zR7cv2QHXks.flac?guid=00000000220dc7310000018e057bcdd7&vkey=E8DC5FB30AEE736DFA46A17CCA24EBF1A89AFDB7FFFD1C430B7EA53D0EEF8A2C1CCE36D9FAE8D91B9C8A8B64EC9EAEDC0D3985A23017A533__v2b9aacfc&uin=335238641&src=F000001CWslf2rktK3.flac&redirect=1&fromtag=111114","trackType":""} Jan 15 19:33:05 volumio-1 volumio[901]: verbose: CURRENT POSITION 0 Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState stateService play Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:33:05 volumio-1 volumio[901]: info: Received an update from plugin. extracting info from payload Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::pushState Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioPushState Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 34ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 33ms Jan 15 19:33:05 volumio-1 volumio[901]: info: ------------------------------ 32ms Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CoreStateMachine::getQueue Jan 15 19:33:05 volumio-1 volumio[901]: info: CorePlayQueue::getQueue Jan 15 19:33:23 volumio-1 volumio[901]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 19:33:23 volumio-1 volumio[901]: Error: connect ETIMEDOUT 199.59.149.210:443 Jan 15 19:33:23 volumio-1 volumio[901]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 15 19:33:23 volumio-1 volumio[901]: errno: -110, Jan 15 19:33:23 volumio-1 volumio[901]: code: 'ETIMEDOUT', Jan 15 19:33:23 volumio-1 volumio[901]: syscall: 'connect', Jan 15 19:33:23 volumio-1 volumio[901]: address: '199.59.149.210', Jan 15 19:33:23 volumio-1 volumio[901]: port: 443 Jan 15 19:33:23 volumio-1 volumio[901]: } Jan 15 19:33:23 volumio-1 volumio[901]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 19:33:23 volumio-1 sudo[26283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 19:32 Jan 15 19:33:23 volumio-1 sudo[26283]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"