-- Logs begin at Wed 2024-07-10 13:55:33 GMT, end at Wed 2024-07-10 14:02:13 GMT. -- Jul 10 14:01:01 volumio volumio[1446]: 100 Jul 10 14:01:01 volumio volumio[1446]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 10 14:01:01 volumio volumio[1446]: Dload Upload Total Spent Left Speed Jul 10 14:01:01 volumio volumio[2009]: info: Jul 10 14:01:01 volumio volumio[2009]: ---------------------------- Client requests Volume 100 Jul 10 14:01:01 volumio volumio[2009]: info: VolumeController::SetAlsaVolume100 Jul 10 14:01:01 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:01 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:01 volumio volumio[1446]: [158B blob data] Jul 10 14:01:01 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:01 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:01 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:01 volumio volumio[1446]: {"time":1720620061957,"response":"volume Success"}100 Jul 10 14:01:02 volumio wpa_supplicant[918]: wlan0: CTRL-EVENT-BEACON-LOSS Jul 10 14:01:09 volumio volumio[1446]: 90 Jul 10 14:01:09 volumio volumio[1446]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 10 14:01:09 volumio volumio[1446]: Dload Upload Total Spent Left Speed Jul 10 14:01:09 volumio volumio[2009]: info: Jul 10 14:01:09 volumio volumio[2009]: ---------------------------- Client requests Volume 90 Jul 10 14:01:09 volumio volumio[2009]: info: VolumeController::SetAlsaVolume90 Jul 10 14:01:09 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:09 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:09 volumio volumio[1446]: [158B blob data] Jul 10 14:01:09 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:09 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:09 volumio volumio[1446]: {"time":1720620069806,"response":"volume Success"}90 Jul 10 14:01:09 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:10 volumio volumio[1446]: 80 Jul 10 14:01:10 volumio volumio[1446]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 10 14:01:10 volumio volumio[1446]: Dload Upload Total Spent Left Speed Jul 10 14:01:10 volumio volumio[2009]: info: Jul 10 14:01:10 volumio volumio[2009]: ---------------------------- Client requests Volume 80 Jul 10 14:01:10 volumio volumio[2009]: info: VolumeController::SetAlsaVolume80 Jul 10 14:01:10 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:10 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:10 volumio volumio[1446]: [158B blob data] Jul 10 14:01:10 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:10 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:10 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:10 volumio volumio[1446]: {"time":1720620070168,"response":"volume Success"}80 Jul 10 14:01:13 volumio volumio[2009]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 10 14:01:13 volumio volumio[2009]: info: Retrying Login Due to Network Error Jul 10 14:01:23 volumio volumio[2009]: info: MyVolumio login type: Token Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand status took 5 milliseconds Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand status took 2 milliseconds Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 14:01:30 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:30 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:30 volumio volumio[2009]: 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":"Shackles","artist":"VodKe","album":"Shackles","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000004JuEDo4YgzTP.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=5FB038EDD6D64B0C96E22D96E8F43264284CAAACF06A0F65A73E118428C9D520A039F9E64AFC8C8C7ED636304F076C72353537AE71AA06C2&uin=28794995&src=F000002iD7CR1S3QC1.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:30 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::stPlaybackTimer Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:30 volumio volumio[2009]: 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":"Shackles","artist":"VodKe","album":"Shackles","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000004JuEDo4YgzTP.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=5FB038EDD6D64B0C96E22D96E8F43264284CAAACF06A0F65A73E118428C9D520A039F9E64AFC8C8C7ED636304F076C72353537AE71AA06C2&uin=28794995&src=F000002iD7CR1S3QC1.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:30 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: No code Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:30 volumio volumio[2009]: 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":"Shackles","artist":"VodKe","album":"Shackles","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000004JuEDo4YgzTP.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=5FB038EDD6D64B0C96E22D96E8F43264284CAAACF06A0F65A73E118428C9D520A039F9E64AFC8C8C7ED636304F076C72353537AE71AA06C2&uin=28794995&src=F000002iD7CR1S3QC1.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:30 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: No code Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 70ms Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 69ms Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 68ms Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:30 volumio volumio[2009]: info: Clearing queue after UPNP request Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::ClearQueue Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::stop Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::clearPlayQueue Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::saveQueue Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioPushQueue Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:30 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:30 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:30 volumio volumio[2009]: info: Jul 10 14:01:30 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:30 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:30 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:30 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:30 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 7ms Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:30 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:30 volumio volumio[2009]: info: Starting UPNP Playback Jul 10 14:01:30 volumio volumio[2009]: info: Preparing playback through UPNP Jul 10 14:01:30 volumio volumio[2009]: info: CoreCommandRouter::volumioGetState Jul 10 14:01:30 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:30 volumio volumio[2009]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 7ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 6ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 6 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 5 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 9 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 34ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 51ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 51ms Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Outlaws","artist":"7OP/MIRBRO","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 107ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 100ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 100ms Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:31 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:31 volumio volumio[2009]: info: Jul 10 14:01:31 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 7ms Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 5 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 5 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand status took 3 milliseconds Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"910 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 25ms Jul 10 14:01:31 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 10 14:01:31 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"875 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:31 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:31 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"826 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:31 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:31 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 60ms Jul 10 14:01:31 volumio volumio[2009]: info: ------------------------------ 60ms Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:31 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:31 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: Jul 10 14:01:34 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:34 volumio volumio[2009]: info: Jul 10 14:01:34 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:34 volumio volumio[2009]: info: Jul 10 14:01:34 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand status took 3 milliseconds Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand status took 2 milliseconds Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand status took 3 milliseconds Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:34 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:34 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:34 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:34 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"936 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:34 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:34 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:34 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:34 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"936 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:34 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:34 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:34 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:34 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"936 Kbps","isStreaming":false,"title":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:34 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:34 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:34 volumio volumio[2009]: info: ------------------------------ 52ms Jul 10 14:01:34 volumio volumio[2009]: info: ------------------------------ 51ms Jul 10 14:01:34 volumio volumio[2009]: info: ------------------------------ 50ms Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:34 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:34 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:45 volumio wpa_supplicant[918]: wlan0: WPA: Group rekeying completed with 4a:12:58:3d:1a:a4 [GTK=CCMP] Jul 10 14:01:52 volumio volumio[2009]: info: Jul 10 14:01:52 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:52 volumio volumio[2009]: info: Jul 10 14:01:52 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:52 volumio volumio[2009]: info: Jul 10 14:01:52 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand status took 3 milliseconds Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand status took 2 milliseconds Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand status took 1 milliseconds Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 14:01:52 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:52 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:52 volumio volumio[2009]: 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":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:52 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::stPlaybackTimer Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:52 volumio volumio[2009]: 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":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:52 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: No code Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:52 volumio volumio[2009]: 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":"Outlaws","artist":"7OP","album":"Outlaws","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F000002HiZjt3V4tkN.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=607D4BA8981054C37A6B0BC124E1ED1AC2B5A41550A74A8BDF03C2E5102A37047FE7BFD77C7FE7E4619B6DB2387D787BE4AF3B73B84B8DAC&uin=28794995&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:52 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState stateService stop Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: No code Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:52 volumio volumio[2009]: info: ------------------------------ 61ms Jul 10 14:01:52 volumio volumio[2009]: info: ------------------------------ 61ms Jul 10 14:01:52 volumio volumio[2009]: info: ------------------------------ 64ms Jul 10 14:01:52 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:52 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:52 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:53 volumio volumio[2009]: info: Clearing queue after UPNP request Jul 10 14:01:53 volumio volumio[2009]: info: CoreStateMachine::ClearQueue Jul 10 14:01:53 volumio volumio[2009]: info: CoreStateMachine::stop Jul 10 14:01:53 volumio volumio[2009]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 14:01:53 volumio volumio[2009]: info: CorePlayQueue::clearPlayQueue Jul 10 14:01:53 volumio volumio[2009]: info: CorePlayQueue::saveQueue Jul 10 14:01:53 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:53 volumio volumio[2009]: info: CoreCommandRouter::volumioPushQueue Jul 10 14:01:53 volumio volumio[2009]: info: Jul 10 14:01:53 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:53 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:53 volumio volumio[2009]: info: Jul 10 14:01:53 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:53 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:53 volumio volumio[2009]: info: Jul 10 14:01:53 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:53 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:53 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:53 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:53 volumio volumio[2009]: error: updateQueue error: null Jul 10 14:01:53 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:53 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:53 volumio volumio[2009]: info: Starting UPNP Playback Jul 10 14:01:53 volumio volumio[2009]: info: Preparing playback through UPNP Jul 10 14:01:53 volumio volumio[2009]: info: CoreCommandRouter::volumioGetState Jul 10 14:01:53 volumio volumio[2009]: info: CorePlayQueue::getTrack 0 Jul 10 14:01:53 volumio volumio[2009]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 14:01:53 volumio volumio[2009]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 10 14:01:53 volumio volumio[2009]: info: Retrying Login Due to Network Error Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 1ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 1ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 3ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 2ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 7 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 5 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 3 milliseconds Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus stop Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:54 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:54 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:54 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 27ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 57ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 57ms Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 57ms Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 50 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:54 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:54 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:54 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:54 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:54 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 100ms Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:54 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces system playlist update Jul 10 14:01:54 volumio volumio[2009]: info: Ignoring MPD Status Update Jul 10 14:01:54 volumio volumio[2009]: info: Jul 10 14:01:54 volumio volumio[2009]: ---------------------------- MPD announces state update: player Jul 10 14:01:54 volumio volumio[2009]: info: ControllerMpd::getState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand status Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 7ms Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 6 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 5ms Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:54 volumio volumio[2009]: info: ------------------------------ 4ms Jul 10 14:01:54 volumio volumio[2009]: info: sendMpdCommand status took 4 milliseconds Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::parseState Jul 10 14:01:54 volumio volumio[2009]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 14:01:56 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2008 milliseconds Jul 10 14:01:56 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2009 milliseconds Jul 10 14:01:56 volumio volumio[2009]: info: sendMpdCommand playlistinfo took 2008 milliseconds Jul 10 14:01:56 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:56 volumio volumio[2009]: verbose: ControllerMpd::parseTrackInfo Jul 10 14:01:56 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:56 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:56 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:56 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:56 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:56 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:56 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:56 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:56 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: ControllerMpd::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::servicePushState Jul 10 14:01:56 volumio volumio[2009]: verbose: In UPNP mode Jul 10 14:01:56 volumio volumio[2009]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"Back to 8","artist":"Else","album":"Back to 8","uri":"http://36.249.84.21/amobile.music.tc.qq.com/F0000010fNhf4QqDdJ.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=E8D8BAD405A08E8688C568233159629F55434C47EA8117F6D9354DD2AA9984EB649B944839247150628BC7C7EE2FE38D7232DAC995F84A6B&uin=28794995&src=F000000hK8Y232BOW4.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 14:01:56 volumio volumio[2009]: verbose: CURRENT POSITION 0 Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState stateService play Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::syncState currentStatus play Jul 10 14:01:56 volumio volumio[2009]: info: Received an update from plugin. extracting info from payload Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::pushState Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioPushState Jul 10 14:01:56 volumio volumio[2009]: info: ------------------------------ 2075ms Jul 10 14:01:56 volumio volumio[2009]: info: ------------------------------ 2073ms Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreCommandRouter::volumioGetQueue Jul 10 14:01:56 volumio volumio[2009]: info: CoreStateMachine::getQueue Jul 10 14:01:56 volumio volumio[2009]: info: CorePlayQueue::getQueue Jul 10 14:02:03 volumio volumio[2009]: info: MyVolumio login type: Token Jul 10 14:02:05 volumio volumio-remote-updater[735]: No test mode Jul 10 14:02:05 volumio volumio-remote-updater[735]: No alpha test mode Jul 10 14:02:05 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 10 14:02:06 volumio volumio[2009]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 10 14:02:06 volumio volumio[2009]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 10 14:02:12 volumio volumio[2009]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 14:02:12 volumio volumio[2009]: Error: connect ETIMEDOUT 157.240.6.35:443 Jul 10 14:02:12 volumio volumio[2009]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 10 14:02:12 volumio volumio[2009]: errno: -110, Jul 10 14:02:12 volumio volumio[2009]: code: 'ETIMEDOUT', Jul 10 14:02:12 volumio volumio[2009]: syscall: 'connect', Jul 10 14:02:12 volumio volumio[2009]: address: '157.240.6.35', Jul 10 14:02:12 volumio volumio[2009]: port: 443 Jul 10 14:02:12 volumio volumio[2009]: } Jul 10 14:02:12 volumio volumio[2009]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 14:02:13 volumio sudo[2694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-10 14:01 Jul 10 14:02:13 volumio sudo[2694]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"