-- Logs begin at Fri 2024-04-19 17:01:20 UTC, end at Fri 2024-04-19 17:15:51 UTC. -- Apr 19 17:14:00 volumio volumio[2885]: info: Apr 19 17:14:00 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:00 volumio volumio[2885]: info: Apr 19 17:14:00 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:00 volumio volumio[2885]: info: Apr 19 17:14:00 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand status took 0 milliseconds Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 19 17:14:00 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:00 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:00 volumio volumio[2885]: 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.hw.kugou.com/202404200113/81921e76339cab1f82f2494ab9f1ca81/v3/2f120b98e8e56270245e16bedfbe37a7/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_q320_s1263084341.mp3","trackType":"mp3"} Apr 19 17:14:00 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::stPlaybackTimer Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:00 volumio volumio[2885]: 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.hw.kugou.com/202404200113/81921e76339cab1f82f2494ab9f1ca81/v3/2f120b98e8e56270245e16bedfbe37a7/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_q320_s1263084341.mp3","trackType":"mp3"} Apr 19 17:14:00 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: No code Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:00 volumio volumio[2885]: 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.hw.kugou.com/202404200113/81921e76339cab1f82f2494ab9f1ca81/v3/2f120b98e8e56270245e16bedfbe37a7/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_q320_s1263084341.mp3","trackType":"mp3"} Apr 19 17:14:00 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: No code Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:00 volumio volumio[2885]: info: ------------------------------ 20ms Apr 19 17:14:00 volumio volumio[2885]: info: ------------------------------ 19ms Apr 19 17:14:00 volumio volumio[2885]: info: ------------------------------ 20ms Apr 19 17:14:00 volumio volumio[2885]: info: CoreCommandRouter::volumioGetQueue Apr 19 17:14:00 volumio volumio[2885]: info: CoreStateMachine::getQueue Apr 19 17:14:00 volumio volumio[2885]: info: CorePlayQueue::getQueue Apr 19 17:14:00 volumio volumio[2885]: info: Clearing queue after UPNP request Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::ClearQueue Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::stop Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 17:14:01 volumio volumio[2885]: info: CorePlayQueue::clearPlayQueue Apr 19 17:14:01 volumio volumio[2885]: info: CorePlayQueue::saveQueue Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushQueue Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:01 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:01 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 2ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: Starting UPNP Playback Apr 19 17:14:01 volumio volumio[2885]: info: Preparing playback through UPNP Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioGetState Apr 19 17:14:01 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 0ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 2ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 0ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 2ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 3ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 5ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 2ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 2 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 7ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 11ms Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 9 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 23ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 24ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 23ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"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.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 36ms Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:01 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:01 volumio volumio[2885]: info: Apr 19 17:14:01 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 8ms Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 8 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 4ms Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand status took 3 milliseconds Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":330,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":330,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 21ms Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 15ms Apr 19 17:14:01 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 19 17:14:01 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:01 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:01 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:01 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":330,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:01 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:01 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:01 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:01 volumio volumio[2885]: info: ------------------------------ 23ms Apr 19 17:14:04 volumio ntpd[1124]: 116.203.151.74 local addr 192.168.1.95 -> Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand status took 0 milliseconds Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:48 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:48 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:48 volumio volumio[2885]: 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":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:48 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::stPlaybackTimer Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:48 volumio volumio[2885]: 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":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:48 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: No code Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:48 volumio volumio[2885]: 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":"a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/f02493d14d83941366398d3313af7d0e/v3/b9ffa885fcbbd4d8e3bb3a4213919858/yp/full/a1005_u892568845_d1j7z7n14cuxw43vhnn0nwlhu_p2_mx436369982_qhigh_s1548814162.flac","trackType":"flac"} Apr 19 17:14:48 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState stateService stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: No code Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: ------------------------------ 21ms Apr 19 17:14:48 volumio volumio[2885]: info: ------------------------------ 20ms Apr 19 17:14:48 volumio volumio[2885]: info: Clearing queue after UPNP request Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::ClearQueue Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::stop Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::clearPlayQueue Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::saveQueue Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioPushQueue Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:48 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:48 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:48 volumio volumio[2885]: info: Apr 19 17:14:48 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:48 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:48 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:48 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:48 volumio volumio[2885]: error: updateQueue error: null Apr 19 17:14:48 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:48 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:48 volumio volumio[2885]: info: ------------------------------ 0ms Apr 19 17:14:48 volumio volumio[2885]: info: Starting UPNP Playback Apr 19 17:14:48 volumio volumio[2885]: info: Preparing playback through UPNP Apr 19 17:14:48 volumio volumio[2885]: info: CoreCommandRouter::volumioGetState Apr 19 17:14:48 volumio volumio[2885]: info: CorePlayQueue::getTrack 0 Apr 19 17:14:48 volumio volumio[2885]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 3ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 4ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 3ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 3ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 0ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: Apr 19 17:14:49 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:49 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:49 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 4 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 6 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 5 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 0 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus stop Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 9ms Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 2 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 27ms Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 27ms Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 22ms Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 23ms Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:50 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露 - 漂洋过海来看你","artist":"孙露","album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 27ms Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:50 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces system playlist update Apr 19 17:14:50 volumio volumio[2885]: info: Ignoring MPD Status Update Apr 19 17:14:50 volumio volumio[2885]: info: Apr 19 17:14:50 volumio volumio[2885]: ---------------------------- MPD announces state update: player Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::getState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand status Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 18ms Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 18 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 3ms Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 1ms Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand status took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseState Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 17:14:50 volumio volumio[2885]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 17:14:50 volumio volumio[2885]: verbose: ControllerMpd::parseTrackInfo Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":235,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":993,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ControllerMpd::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::servicePushState Apr 19 17:14:50 volumio volumio[2885]: verbose: In UPNP mode Apr 19 17:14:50 volumio volumio[2885]: verbose: STATE SERVICE {"status":"play","position":0,"seek":993,"duration":325,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","artist":null,"album":null,"uri":"http://fsandroid.hw.kugou.com/202404200114/04157f28fc71f3327ca67df0c22f7d12/v3/d7dd9fecdfa6a5b06d4b261637d521d9/yp/full/a1005_u892568845_d3esbip14cv3i0uw9vt28sboa_p2_mx28174834_qhigh_s3502950529.flac","trackType":"flac"} Apr 19 17:14:50 volumio volumio[2885]: verbose: CURRENT POSITION 0 Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState stateService play Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::syncState currentStatus play Apr 19 17:14:50 volumio volumio[2885]: info: Received an update from plugin. extracting info from payload Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:14:50 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 37ms Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 20ms Apr 19 17:14:50 volumio volumio[2885]: info: ------------------------------ 20ms Apr 19 17:15:10 volumio ntpd[1124]: 162.159.200.123 local addr 192.168.1.95 -> Apr 19 17:15:29 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:29 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:29 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:29 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:30 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:30 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:30 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:30 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:30 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:30 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:30 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:30 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:30 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:30 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:30 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:31 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:31 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:31 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:31 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:31 volumio volumio[2885]: info: VolumeController::SetAlsaVolume- Apr 19 17:15:31 volumio volumio[2885]: info: CoreStateMachine::pushState Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 17:15:31 volumio volumio[2885]: info: CoreCommandRouter::volumioPushState Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 17:15:34 volumio volumio[2885]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 17:15:48 volumio volumio[2885]: info: CoreCommandRouter::volumioGetState Apr 19 17:15:50 volumio volumio[2885]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 17:15:50 volumio volumio[2885]: Error: connect ETIMEDOUT 199.59.149.210:443 Apr 19 17:15:50 volumio volumio[2885]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 19 17:15:50 volumio volumio[2885]: errno: -110, Apr 19 17:15:50 volumio volumio[2885]: code: 'ETIMEDOUT', Apr 19 17:15:50 volumio volumio[2885]: syscall: 'connect', Apr 19 17:15:50 volumio volumio[2885]: address: '199.59.149.210', Apr 19 17:15:50 volumio volumio[2885]: port: 443 Apr 19 17:15:50 volumio volumio[2885]: } Apr 19 17:15:50 volumio volumio[2885]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 17:15:51 volumio sudo[5383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 17:14 Apr 19 17:15:51 volumio sudo[5383]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"