-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2025-01-15 19:38:40 CST. -- Jan 15 19:37:00 volumio ntpd[752]: Soliciting pool server 162.159.200.1 Jan 15 19:37:00 volumio ntpd[752]: Soliciting pool server 81.16.177.123 Jan 15 19:37:00 volumio volumio[787]: info: Clearing queue after UPNP request Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::ClearQueue Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::stPlaybackTimer Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::updateTrackBlock Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrackBlock Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::serviceStop Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::stop Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::clearPlayQueue Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::saveQueue Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:37:00 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 15 19:37:00 volumio volumio[787]: info: sendMpdCommand stop took 31 milliseconds Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:00 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:00 volumio volumio[787]: info: sendMpdCommand status took 9 milliseconds Jan 15 19:37:00 volumio volumio[787]: info: sendMpdCommand status took 6 milliseconds Jan 15 19:37:00 volumio volumio[787]: info: sendMpdCommand status took 5 milliseconds Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:00 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 19:37:00 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState stateService stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: No code Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 19:37:00 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState stateService stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: No code Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 19:37:00 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState stateService stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: No code Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 75ms Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 73ms Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 72ms Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:00 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:00 volumio volumio[787]: info: Jan 15 19:37:00 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:00 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:00 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:00 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:00 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 76ms Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:00 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:00 volumio volumio[787]: info: Starting UPNP Playback Jan 15 19:37:00 volumio volumio[787]: info: Preparing playback through UPNP Jan 15 19:37:00 volumio volumio[787]: info: CoreCommandRouter::volumioGetState Jan 15 19:37:00 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:00 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:37:01 volumio ntpd[752]: Soliciting pool server 78.46.102.180 Jan 15 19:37:01 volumio ntpd[752]: Soliciting pool server 2001:67c:21bc:1e::123 Jan 15 19:37:01 volumio volumio[787]: info: Clearing queue after UPNP request Jan 15 19:37:01 volumio volumio[787]: info: CoreStateMachine::ClearQueue Jan 15 19:37:01 volumio volumio[787]: info: CoreStateMachine::stop Jan 15 19:37:01 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:37:01 volumio volumio[787]: info: CorePlayQueue::clearPlayQueue Jan 15 19:37:01 volumio volumio[787]: info: CorePlayQueue::saveQueue Jan 15 19:37:01 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:01 volumio volumio[787]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:37:01 volumio volumio[787]: info: Jan 15 19:37:01 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:01 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:01 volumio volumio[787]: info: Jan 15 19:37:01 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:01 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:01 volumio volumio[787]: info: Jan 15 19:37:01 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:01 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:01 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:01 volumio volumio[787]: info: ------------------------------ 13ms Jan 15 19:37:01 volumio volumio[787]: info: ------------------------------ 12ms Jan 15 19:37:01 volumio volumio[787]: info: ------------------------------ 10ms Jan 15 19:37:01 volumio volumio[787]: info: Starting UPNP Playback Jan 15 19:37:01 volumio volumio[787]: info: Preparing playback through UPNP Jan 15 19:37:01 volumio volumio[787]: info: CoreCommandRouter::volumioGetState Jan 15 19:37:01 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:01 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:37:02 volumio volumio[787]: info: Clearing queue after UPNP request Jan 15 19:37:02 volumio volumio[787]: info: CoreStateMachine::ClearQueue Jan 15 19:37:02 volumio volumio[787]: info: CoreStateMachine::stop Jan 15 19:37:02 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 19:37:02 volumio volumio[787]: info: CorePlayQueue::clearPlayQueue Jan 15 19:37:02 volumio volumio[787]: info: CorePlayQueue::saveQueue Jan 15 19:37:02 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:02 volumio volumio[787]: info: CoreCommandRouter::volumioPushQueue Jan 15 19:37:02 volumio volumio[787]: info: Jan 15 19:37:02 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:02 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:02 volumio volumio[787]: info: Jan 15 19:37:02 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:02 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:02 volumio volumio[787]: info: Jan 15 19:37:02 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:02 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:02 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:02 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:02 volumio volumio[787]: error: updateQueue error: null Jan 15 19:37:02 volumio volumio[787]: info: ------------------------------ 7ms Jan 15 19:37:02 volumio volumio[787]: info: ------------------------------ 6ms Jan 15 19:37:02 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:02 volumio volumio[787]: info: Starting UPNP Playback Jan 15 19:37:02 volumio volumio[787]: info: Preparing playback through UPNP Jan 15 19:37:02 volumio volumio[787]: info: CoreCommandRouter::volumioGetState Jan 15 19:37:02 volumio volumio[787]: info: CorePlayQueue::getTrack 0 Jan 15 19:37:02 volumio volumio[787]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 8ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 7ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 8ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 6ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 4ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 8ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 3ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 7ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 3ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 7ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 5ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 4ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 6ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 4ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 4ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 9 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 15 milliseconds Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 28 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 19 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 18 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 12 milliseconds Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus stop Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 72ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 80ms Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces system playlist update Jan 15 19:37:03 volumio volumio[787]: info: Ignoring MPD Status Update Jan 15 19:37:03 volumio volumio[787]: info: Jan 15 19:37:03 volumio volumio[787]: ---------------------------- MPD announces state update: player Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::getState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand status Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 63 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 62ms Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 58 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 14ms Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 13 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 12ms Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 154ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 151ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 136ms Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand status took 98 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 87 milliseconds Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 85 milliseconds Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseState Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 203ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 199ms Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 151ms Jan 15 19:37:03 volumio volumio[787]: info: sendMpdCommand playlistinfo took 47 milliseconds Jan 15 19:37:03 volumio volumio[787]: verbose: ControllerMpd::parseTrackInfo Jan 15 19:37:03 volumio volumio[787]: info: ControllerMpd::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::servicePushState Jan 15 19:37:03 volumio volumio[787]: verbose: In UPNP mode Jan 15 19:37:03 volumio volumio[787]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"476 Kbps","isStreaming":false,"title":"人生不过三杯酒","artist":"花姐","album":"人生不过三杯酒","uri":"http://aqqmusic.tc.qq.com/F0000037EaP81hhOxq.flac?guid=34AE89E2F46045448E881C33FD414503&vkey=0C077A6D100AB8A48604EB8C9BA129FFA427BD4D65EF467482F14966CF3D8EDF9F75C0509853AC5C4FB68D47DCD50402F1B7E9364E88EB70__v21e2a16ad&uin=1152921504892443065&src=F000003hhJ9q03HA1W.flac&redirect=1&fromtag=101114","trackType":""} Jan 15 19:37:03 volumio volumio[787]: verbose: CURRENT POSITION 0 Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState stateService play Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::syncState currentStatus play Jan 15 19:37:03 volumio volumio[787]: info: Received an update from plugin. extracting info from payload Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::pushState Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioPushState Jan 15 19:37:03 volumio volumio[787]: info: ------------------------------ 162ms Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreCommandRouter::volumioGetQueue Jan 15 19:37:03 volumio volumio[787]: info: CoreStateMachine::getQueue Jan 15 19:37:03 volumio volumio[787]: info: CorePlayQueue::getQueue Jan 15 19:37:05 volumio ntpd[752]: receive: Unexpected origin timestamp 0xeb321c61.0af92974 does not match aorg 0000000000.00000000 from server@81.16.177.123 xmt 0xeb321c61.bb7e436c Jan 15 19:38:40 volumio volumio[787]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 19:38:40 volumio volumio[787]: Error: connect ETIMEDOUT 199.16.156.7:443 Jan 15 19:38:40 volumio volumio[787]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 15 19:38:40 volumio volumio[787]: errno: -110, Jan 15 19:38:40 volumio volumio[787]: code: 'ETIMEDOUT', Jan 15 19:38:40 volumio volumio[787]: syscall: 'connect', Jan 15 19:38:40 volumio volumio[787]: address: '199.16.156.7', Jan 15 19:38:40 volumio volumio[787]: port: 443 Jan 15 19:38:40 volumio volumio[787]: } Jan 15 19:38:40 volumio volumio[787]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 19:38:40 volumio sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 19:37 Jan 15 19:38:40 volumio sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"