-- Logs begin at Tue 2024-10-01 18:57:16 UTC, end at Tue 2024-10-01 19:11:56 UTC. -- Oct 01 19:10:07 volumio ntpd[981]: 193.182.111.14 local addr 192.168.3.35 -> Oct 01 19:10:18 volumio volumio[992]: info: Oct 01 19:10:18 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:18 volumio volumio[992]: info: Oct 01 19:10:18 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:18 volumio volumio[992]: info: Oct 01 19:10:18 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand status took 4 milliseconds Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand status took 5 milliseconds Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand status took 3 milliseconds Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:18 volumio volumio[992]: 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":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:18 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:10:18 volumio volumio[992]: info: ------------------------------ 33ms Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 01 19:10:18 volumio volumio[992]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:18 volumio volumio[992]: 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":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:18 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: No code Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:18 volumio volumio[992]: 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":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:18 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: No code Oct 01 19:10:18 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:18 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:18 volumio volumio[992]: info: ------------------------------ 93ms Oct 01 19:10:18 volumio volumio[992]: info: ------------------------------ 91ms Oct 01 19:10:18 volumio volumio[992]: info: Clearing queue after UPNP request Oct 01 19:10:18 volumio volumio[992]: info: Oct 01 19:10:18 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:18 volumio volumio[992]: info: Oct 01 19:10:18 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:18 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:18 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 20 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 12 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 4 milliseconds Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 8 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 4 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 3 milliseconds Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:19 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:19 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 54ms Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 135ms Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 125ms Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand playlistinfo took 112 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand playlistinfo took 113 milliseconds Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:19 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:19 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23000,"duration":156,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"红孩儿 - 山鬼喝不了道士的酒","artist":"红孩儿","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020309/dae1b03614ec21e638912df376cf3b05/v3/b3573fcd68ad74a5a4d845504088e3d6/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_atmos_s2540430506.flac","trackType":"flac"} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:19 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 392ms Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 388ms Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 387ms Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::ClearQueue Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::updateTrackBlock Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrackBlock Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::serviceStop Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::stop Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::saveQueue Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand stop took 122 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:19 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 3 milliseconds Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: No code Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 39ms Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:19 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:19 volumio volumio[992]: error: updateQueue error: null Oct 01 19:10:19 volumio volumio[992]: error: updateQueue error: null Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 38 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 39ms Oct 01 19:10:19 volumio volumio[992]: info: sendMpdCommand status took 3 milliseconds Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: No code Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 01 19:10:19 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: No code Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 97ms Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 62ms Oct 01 19:10:19 volumio volumio[992]: info: Oct 01 19:10:19 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:19 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:19 volumio volumio[992]: error: updateQueue error: null Oct 01 19:10:19 volumio volumio[992]: info: ------------------------------ 11ms Oct 01 19:10:19 volumio volumio[992]: info: Starting UPNP Playback Oct 01 19:10:19 volumio volumio[992]: info: Preparing playback through UPNP Oct 01 19:10:19 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Oct 01 19:10:19 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:10:19 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 4ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 4ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 4ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 1ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 1ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 4ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 1ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 24 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 17 milliseconds Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 44 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 34 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 139ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 191ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 173 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 172 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 163ms Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 154 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 152 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 148 milliseconds Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":443,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 331ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 325ms Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:10:20 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:10:20 volumio volumio[992]: info: Oct 01 19:10:20 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 156ms Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 152 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 138 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 136 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 134 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 12ms Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand status took 11 milliseconds Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":739,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 387ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 383ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 369ms Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 75 milliseconds Oct 01 19:10:20 volumio volumio[992]: info: sendMpdCommand playlistinfo took 74 milliseconds Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1104,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:10:20 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:10:20 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":156,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:10:20 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:10:20 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 270ms Oct 01 19:10:20 volumio volumio[992]: info: ------------------------------ 127ms Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:10:20 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:10:20 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:11:08 volumio volumio[992]: info: Oct 01 19:11:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:08 volumio volumio[992]: info: Oct 01 19:11:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:08 volumio volumio[992]: info: Oct 01 19:11:08 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand status took 3 milliseconds Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand status took 2 milliseconds Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand status took 4 milliseconds Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:11:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:11:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:11:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:11:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: No code Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: ------------------------------ 61ms Oct 01 19:11:08 volumio volumio[992]: info: ------------------------------ 61ms Oct 01 19:11:08 volumio volumio[992]: info: sendMpdCommand playlistinfo took 54 milliseconds Oct 01 19:11:08 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:08 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:11:08 volumio volumio[992]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"山鬼喝不了道士的酒","artist":"红孩儿","album":"山鬼喝不了道士的酒","uri":"http://fsandroid.tx.kugou.com/202410020310/87819f364091917f07597427504a9c5e/v3/97ef4d614131a3e76b3c6a2f1cee4b26/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx627332320_quviper_tape_s370189994.mp3","trackType":"mp3"} Oct 01 19:11:08 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState stateService stop Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: No code Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:08 volumio volumio[992]: info: ------------------------------ 95ms Oct 01 19:11:08 volumio volumio[992]: info: CoreCommandRouter::volumioGetQueue Oct 01 19:11:08 volumio volumio[992]: info: CoreStateMachine::getQueue Oct 01 19:11:08 volumio volumio[992]: info: CorePlayQueue::getQueue Oct 01 19:11:08 volumio volumio[992]: info: Clearing queue after UPNP request Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::ClearQueue Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::stop Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 19:11:09 volumio volumio[992]: info: CorePlayQueue::clearPlayQueue Oct 01 19:11:09 volumio volumio[992]: info: CorePlayQueue::saveQueue Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushQueue Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: error: updateQueue error: null Oct 01 19:11:09 volumio volumio[992]: error: updateQueue error: null Oct 01 19:11:09 volumio volumio[992]: error: updateQueue error: null Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 4ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Starting UPNP Playback Oct 01 19:11:09 volumio volumio[992]: info: Preparing playback through UPNP Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioGetState Oct 01 19:11:09 volumio volumio[992]: info: CorePlayQueue::getTrack 0 Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 3ms Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 1ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces system playlist update Oct 01 19:11:09 volumio volumio[992]: info: Ignoring MPD Status Update Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 2ms Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 31 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 33 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 31 milliseconds Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: info: Oct 01 19:11:09 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 21 milliseconds Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 32 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand status took 29 milliseconds Oct 01 19:11:09 volumio volumio[992]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:09 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:09 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:09 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:09 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus stop Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:09 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:09 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:09 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:09 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:09 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:09 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:09 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:09 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:09 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:09 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:09 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:09 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:09 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:09 volumio volumio[992]: info: ------------------------------ 266ms Oct 01 19:11:10 volumio volumio[992]: info: ------------------------------ 335ms Oct 01 19:11:10 volumio volumio[992]: info: ------------------------------ 334ms Oct 01 19:11:10 volumio volumio[992]: info: ------------------------------ 311ms Oct 01 19:11:10 volumio volumio[992]: info: sendMpdCommand playlistinfo took 248 milliseconds Oct 01 19:11:10 volumio volumio[992]: info: sendMpdCommand playlistinfo took 245 milliseconds Oct 01 19:11:10 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:10 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:10 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:10 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:10 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:10 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:10 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:10 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:10 volumio volumio[992]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:10 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::syncState stateService play Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:10 volumio volumio[992]: info: Received an update from plugin. extracting info from payload Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:10 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:10 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:10 volumio volumio[992]: info: ------------------------------ 340ms Oct 01 19:11:10 volumio volumio[992]: info: ------------------------------ 339ms Oct 01 19:11:13 volumio ntpd[981]: 108.59.2.24 local addr 192.168.3.35 -> Oct 01 19:11:29 volumio volumio[992]: info: Oct 01 19:11:29 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:29 volumio volumio[992]: info: Oct 01 19:11:29 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:29 volumio volumio[992]: info: Oct 01 19:11:29 volumio volumio[992]: ---------------------------- MPD announces state update: player Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::getState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand status Oct 01 19:11:29 volumio volumio[992]: info: sendMpdCommand status took 8 milliseconds Oct 01 19:11:29 volumio volumio[992]: info: sendMpdCommand status took 4 milliseconds Oct 01 19:11:29 volumio volumio[992]: info: sendMpdCommand status took 2 milliseconds Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::parseState Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 19:11:29 volumio volumio[992]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 01 19:11:29 volumio volumio[992]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 01 19:11:29 volumio volumio[992]: verbose: ControllerMpd::parseTrackInfo Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:29 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:29 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20865,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:29 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:29 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:29 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20865,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:29 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:11:29 volumio volumio[992]: info: ControllerMpd::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::servicePushState Oct 01 19:11:29 volumio volumio[992]: verbose: In UPNP mode Oct 01 19:11:29 volumio volumio[992]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20865,"duration":159,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"宋盐球 - 钱来钱来","artist":"宋盐球","album":null,"uri":"http://fsandroid.tx.kugou.com/202410020311/b3bbdfaf65cc1754e6553eb9014c0ce4/v3/16471e6d150111b57f91e3705715dc96/yp/full/ap1005_us351140446_df3wdya807ryzg3lkhtv0jnmzp_pi2_mx571995948_quviper_tape_s331830072.mp3","trackType":"mp3"} Oct 01 19:11:29 volumio volumio[992]: verbose: CURRENT POSITION 0 Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState stateService pause Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::syncState currentStatus play Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::pushState Oct 01 19:11:29 volumio volumio[992]: info: CoreCommandRouter::volumioPushState Oct 01 19:11:29 volumio volumio[992]: info: CoreStateMachine::stPlaybackTimer Oct 01 19:11:29 volumio volumio[992]: info: ------------------------------ 64ms Oct 01 19:11:29 volumio volumio[992]: info: ------------------------------ 60ms Oct 01 19:11:29 volumio volumio[992]: info: ------------------------------ 60ms Oct 01 19:11:48 volumio kernel: usb 3-1: USB disconnect, device number 2 Oct 01 19:11:48 volumio volumio[992]: info: Oct 01 19:11:48 volumio volumio[992]: ---------------------------- USB Audio Device Detached Oct 01 19:11:48 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 01 19:11:48 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 01 19:11:48 volumio volumio[992]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 01 19:11:48 volumio systemd[1]: Starting Cleanup of Temporary Directories... Oct 01 19:11:48 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Oct 01 19:11:48 volumio systemd[1]: Started Cleanup of Temporary Directories. Oct 01 19:11:55 volumio volumio[992]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 19:11:55 volumio volumio[992]: Error: connect ETIMEDOUT 157.240.3.8:80 Oct 01 19:11:55 volumio volumio[992]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 01 19:11:55 volumio volumio[992]: errno: -110, Oct 01 19:11:55 volumio volumio[992]: code: 'ETIMEDOUT', Oct 01 19:11:55 volumio volumio[992]: syscall: 'connect', Oct 01 19:11:55 volumio volumio[992]: address: '157.240.3.8', Oct 01 19:11:55 volumio volumio[992]: port: 80 Oct 01 19:11:55 volumio volumio[992]: } Oct 01 19:11:55 volumio volumio[992]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 19:11:56 volumio sudo[5382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 19:10 Oct 01 19:11:56 volumio sudo[5382]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"