-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2024-10-21 14:41:38 CEST. -- Oct 21 14:40:00 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::ClearQueue Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::serviceStop Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::serviceStop Oct 21 14:40:00 volumio volumio[969]: info: [1729514400341] ControllerWebradio::stop Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::clearPlayQueue Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::addQueueItems Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::addQueueItems Oct 21 14:40:00 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:00 volumio volumio[969]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s71241 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand stop took 24 milliseconds Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: 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":"FOREVER FUN, FOREVER YOUNG","artist":"Piterpan","album":null,"uri":"https://ice02.fluidstream.net/piterpan.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:00 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: No code Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: 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":"FOREVER FUN, FOREVER YOUNG","artist":"Piterpan","album":null,"uri":"https://ice02.fluidstream.net/piterpan.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:00 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: No code Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: 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":"FOREVER FUN, FOREVER YOUNG","artist":"Piterpan","album":null,"uri":"https://ice02.fluidstream.net/piterpan.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:00 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: No code Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:00 volumio volumio[969]: info: ------------------------------ 33ms Oct 21 14:40:00 volumio volumio[969]: info: ------------------------------ 33ms Oct 21 14:40:00 volumio volumio[969]: info: ------------------------------ 33ms Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:00 volumio volumio[969]: info: CoreCommandRouter::volumioPlay Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::play index 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::play index undefined Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: CoreStateMachine::startPlaybackTimer Oct 21 14:40:00 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:00 volumio volumio[969]: info: [1729514400743] ControllerWebradio::clearAddPlayTrack Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand stop took 6 milliseconds Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clear Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:00 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:00 volumio volumio[969]: info: sendMpdCommand clear took 1 milliseconds Oct 21 14:40:00 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand load "http://onair18.xdevel.com:8128" Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:00 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:00 volumio volumio[969]: info: Oct 21 14:40:00 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:00 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:00 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:00 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand add "http://onair18.xdevel.com:8128" Oct 21 14:40:02 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 1372ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 1371ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand add "http://onair18.xdevel.com:8128" took 2 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand play Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand play took 4 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 3ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 2ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 2ms Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 11ms Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 31ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 31ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 30ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"onair18.xdevel.com:8128","artist":null,"album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 47ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 47ms Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 7ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 6 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 3ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: Oct 21 14:40:02 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:02 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 11ms Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 6ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:02 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:02 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:02 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:02 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:02 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 51ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 51ms Oct 21 14:40:02 volumio volumio[969]: info: ------------------------------ 50ms Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:03 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:03 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:03 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:03 volumio volumio[969]: info: Oct 21 14:40:03 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 3ms Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:03 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:03 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:03 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:03 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2233,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:03 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:03 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:03 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:03 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2233,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:03 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:03 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:03 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:03 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2233,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:03 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:03 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:03 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 29ms Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 27ms Oct 21 14:40:03 volumio volumio[969]: info: ------------------------------ 27ms Oct 21 14:40:06 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::ClearQueue Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::serviceStop Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::serviceStop Oct 21 14:40:06 volumio volumio[969]: info: [1729514406227] ControllerWebradio::stop Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::clearPlayQueue Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::addQueueItems Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::addQueueItems Oct 21 14:40:06 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:06 volumio volumio[969]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s251524 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand stop took 22 milliseconds Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand status took 6 milliseconds Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: 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":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:06 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: No code Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: 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":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:06 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: No code Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: 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":"Sam Sparro - I Wish I Never Met You","artist":"Radio Adige","album":null,"uri":"http://onair18.xdevel.com:8128","trackType":"com:8128"} Oct 21 14:40:06 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: No code Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:06 volumio volumio[969]: info: ------------------------------ 38ms Oct 21 14:40:06 volumio volumio[969]: info: ------------------------------ 37ms Oct 21 14:40:06 volumio volumio[969]: info: ------------------------------ 37ms Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:06 volumio volumio[969]: info: CoreCommandRouter::volumioPlay Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::play index 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::play index undefined Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: CoreStateMachine::startPlaybackTimer Oct 21 14:40:06 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:06 volumio volumio[969]: info: [1729514406558] ControllerWebradio::clearAddPlayTrack Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand stop took 7 milliseconds Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clear Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:06 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:06 volumio volumio[969]: info: sendMpdCommand clear took 1 milliseconds Oct 21 14:40:06 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand load "https://ice07.fluidstream.net/lovefm.mp3?FLID=3" Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:06 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:06 volumio volumio[969]: info: Oct 21 14:40:06 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:06 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:06 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:06 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:08 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand add "https://ice07.fluidstream.net/lovefm.mp3?FLID=3" Oct 21 14:40:08 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:08 volumio volumio[969]: info: Oct 21 14:40:08 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:08 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:08 volumio volumio[969]: info: ------------------------------ 2153ms Oct 21 14:40:08 volumio volumio[969]: info: ------------------------------ 2152ms Oct 21 14:40:08 volumio volumio[969]: info: sendMpdCommand add "https://ice07.fluidstream.net/lovefm.mp3?FLID=3" took 2 milliseconds Oct 21 14:40:08 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 21 14:40:08 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand play Oct 21 14:40:08 volumio volumio[969]: info: Oct 21 14:40:08 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:08 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:08 volumio volumio[969]: info: Oct 21 14:40:08 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:08 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:08 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:08 volumio volumio[969]: info: sendMpdCommand play took 5 milliseconds Oct 21 14:40:08 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:08 volumio volumio[969]: info: ------------------------------ 2ms Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 11ms Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 7 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 40ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 38ms Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"lovefm.mp3?FLID=3","artist":null,"album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 66ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 63ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 63ms Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 44ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 43 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 6ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:09 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:09 volumio volumio[969]: info: Oct 21 14:40:09 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 14ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 13 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 10ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 9 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 9ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand status took 9 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 78ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 41ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 39ms Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 21 14:40:09 volumio volumio[969]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:09 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:09 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:09 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:09 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:09 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 59ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 54ms Oct 21 14:40:09 volumio volumio[969]: info: ------------------------------ 53ms Oct 21 14:40:15 volumio volumio[969]: info: VolumeController::SetAlsaVolume11 Oct 21 14:40:15 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:15 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:15 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:16 volumio volumio[969]: info: VolumeController::SetAlsaVolume7 Oct 21 14:40:16 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:16 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:16 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:17 volumio volumio[969]: info: VolumeController::SetAlsaVolume14 Oct 21 14:40:17 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:17 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:17 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:18 volumio volumio[969]: info: VolumeController::SetAlsaVolume15 Oct 21 14:40:18 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:18 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:18 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:18 volumio volumio[969]: info: VolumeController::SetAlsaVolume22 Oct 21 14:40:18 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:18 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:18 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:19 volumio volumio[969]: info: VolumeController::SetAlsaVolume50 Oct 21 14:40:19 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:19 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:19 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:20 volumio volumio[969]: info: VolumeController::SetAlsaVolume48 Oct 21 14:40:20 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:20 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:20 volumio volumio[969]: info: VolumeController::SetAlsaVolume35 Oct 21 14:40:20 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:20 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:21 volumio volumio[969]: info: VolumeController::SetAlsaVolume34 Oct 21 14:40:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:21 volumio volumio[969]: info: VolumeController::SetAlsaVolume26 Oct 21 14:40:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:21 volumio volumio[969]: info: VolumeController::SetAlsaVolume25 Oct 21 14:40:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:22 volumio volumio[969]: info: VolumeController::SetAlsaVolume15 Oct 21 14:40:23 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:23 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:23 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:24 volumio volumio[969]: info: VolumeController::SetAlsaVolume64 Oct 21 14:40:24 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:24 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:24 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:25 volumio volumio[969]: info: VolumeController::SetAlsaVolume60 Oct 21 14:40:25 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:25 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:25 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:25 volumio volumio[969]: info: VolumeController::SetAlsaVolume40 Oct 21 14:40:25 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:25 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:25 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:26 volumio volumio[969]: info: VolumeController::SetAlsaVolume51 Oct 21 14:40:26 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:26 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:26 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:28 volumio volumio[969]: info: VolumeController::SetAlsaVolume72 Oct 21 14:40:28 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:28 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:29 volumio volumio[969]: info: VolumeController::SetAlsaVolume71 Oct 21 14:40:29 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:29 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:29 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:31 volumio volumio[969]: info: VolumeController::SetAlsaVolume54 Oct 21 14:40:31 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:31 volumio volumio[969]: info: VolumeController::SetAlsaVolume53 Oct 21 14:40:31 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:31 volumio volumio[969]: info: VolumeController::SetAlsaVolume52 Oct 21 14:40:31 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:31 volumio volumio[969]: info: VolumeController::SetAlsaVolume51 Oct 21 14:40:31 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:31 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:33 volumio volumio[969]: info: VolumeController::SetAlsaVolume39 Oct 21 14:40:33 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:33 volumio volumio[969]: info: VolumeController::SetAlsaVolume38 Oct 21 14:40:33 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:33 volumio volumio[969]: info: VolumeController::SetAlsaVolume37 Oct 21 14:40:33 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:33 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:34 volumio volumio[969]: info: VolumeController::SetAlsaVolume32 Oct 21 14:40:34 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:34 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:34 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:36 volumio volumio[969]: info: VolumeController::SetAlsaVolume36 Oct 21 14:40:36 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:36 volumio volumio[969]: info: VolumeController::SetAlsaVolume29 Oct 21 14:40:36 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:36 volumio volumio[969]: info: VolumeController::SetAlsaVolume28 Oct 21 14:40:36 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:36 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 21 14:40:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 21 14:40:55 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::ClearQueue Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::serviceStop Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::serviceStop Oct 21 14:40:55 volumio volumio[969]: info: [1729514455988] ControllerWebradio::stop Oct 21 14:40:55 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::clearPlayQueue Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:55 volumio volumio[969]: info: CoreStateMachine::addQueueItems Oct 21 14:40:55 volumio volumio[969]: info: CorePlayQueue::addQueueItems Oct 21 14:40:55 volumio volumio[969]: info: Preload queue cleared Oct 21 14:40:55 volumio volumio[969]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s74182 Oct 21 14:40:55 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand stop took 23 milliseconds Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: 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":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:56 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: No code Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: 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":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:56 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: No code Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: 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":"JUSTIN TIMBERLAKE - SELFISH","artist":"Love Fm","album":null,"uri":"https://ice07.fluidstream.net/lovefm.mp3?FLID=3","trackType":"mp3"} Oct 21 14:40:56 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState stateService stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: No code Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:56 volumio volumio[969]: info: ------------------------------ 38ms Oct 21 14:40:56 volumio volumio[969]: info: ------------------------------ 37ms Oct 21 14:40:56 volumio volumio[969]: info: ------------------------------ 36ms Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPushQueue Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::saveQueue Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 21 14:40:56 volumio volumio[969]: info: CoreCommandRouter::volumioPlay Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::play index 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::stop Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::play index undefined Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: CoreStateMachine::startPlaybackTimer Oct 21 14:40:56 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:56 volumio volumio[969]: info: [1729514456332] ControllerWebradio::clearAddPlayTrack Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand stop took 3 milliseconds Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand clear Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:56 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:56 volumio volumio[969]: info: sendMpdCommand clear took 1 milliseconds Oct 21 14:40:56 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand load "http://nr8.newradio.it:9065/" Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:56 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:56 volumio volumio[969]: info: Oct 21 14:40:56 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:56 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:56 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:56 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand add "http://nr8.newradio.it:9065/" Oct 21 14:40:57 volumio volumio[969]: error: updateQueue error: null Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 761ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 760ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand add "http://nr8.newradio.it:9065/" took 2 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand play Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 5ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand play took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 3ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 2ms Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 6 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 2 milliseconds Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus stop Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 23ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 29ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 28ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 60ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 57ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 57ms Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces system playlist update Oct 21 14:40:57 volumio volumio[969]: info: Ignoring MPD Status Update Oct 21 14:40:57 volumio volumio[969]: info: Oct 21 14:40:57 volumio volumio[969]: ---------------------------- MPD announces state update: player Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::getState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand status Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 6ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 5 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 4ms Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand status took 3 milliseconds Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseState Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 21 14:40:57 volumio volumio[969]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: verbose: ControllerMpd::parseTrackInfo Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"","artist":"Radio Club 103 Dolomiti","album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"","artist":"Radio Club 103 Dolomiti","album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ControllerMpd::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 21 14:40:57 volumio volumio[969]: info: CorePlayQueue::getTrack 0 Oct 21 14:40:57 volumio volumio[969]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"","artist":"Radio Club 103 Dolomiti","album":null,"uri":"http://nr8.newradio.it:9065/","trackType":"it:9065/"} Oct 21 14:40:57 volumio volumio[969]: verbose: CURRENT POSITION 0 Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState stateService play Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::syncState currentStatus play Oct 21 14:40:57 volumio volumio[969]: info: Received an update from plugin. extracting info from payload Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: CoreStateMachine::pushState Oct 21 14:40:57 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 37ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 36ms Oct 21 14:40:57 volumio volumio[969]: info: ------------------------------ 36ms Oct 21 14:41:06 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 21 14:41:06 volumio volumio[969]: info: CURURI: music-library Oct 21 14:41:06 volumio volumio[969]: info: Preload queue cleared Oct 21 14:41:08 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 21 14:41:08 volumio volumio[969]: info: CURURI: music-library/NAS Oct 21 14:41:08 volumio volumio[969]: error: Failed LSINFO: null Oct 21 14:41:08 volumio volumio[969]: info: Preload queue cleared Oct 21 14:41:11 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 21 14:41:11 volumio volumio[969]: info: CURURI: music-library/INTERNAL Oct 21 14:41:11 volumio volumio[969]: info: Preload queue cleared Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: info: Retrieving Cloud Streaming UI Oct 21 14:41:22 volumio volumio[969]: info: Getting Tidal Cloud Configuration Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: info: Getting Qobuz Cloud Configuration Oct 21 14:41:22 volumio volumio[969]: info: Asking plugin for UI Config Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: info: Getting Spotify Cloud Configuration Oct 21 14:41:22 volumio volumio[969]: info: Asking plugin for UI Config Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: info: Saving Spotify Acccount Oct 21 14:41:22 volumio volumio[969]: info: Got Tidal Cloud Configuration Oct 21 14:41:22 volumio volumio[969]: info: Got it Oct 21 14:41:22 volumio volumio[969]: info: Got it Oct 21 14:41:22 volumio volumio[969]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 14:41:22 volumio volumio[969]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 21 14:41:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 21 14:41:26 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 21 14:41:30 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 21 14:41:33 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 21 14:41:33 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 21 14:41:34 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 21 14:41:35 volumio volumio[969]: info: Error browsing device Seneca for shares : Error: Command failed: echo volumio | smbclient -L fritz.box. Oct 21 14:41:35 volumio volumio[969]: Unable to initialize messaging context Oct 21 14:41:35 volumio volumio[969]: info: Error browsing device fritz-box for shares : Error: Command failed: echo volumio | smbclient -L fritz.box. Oct 21 14:41:35 volumio volumio[969]: Unable to initialize messaging context Oct 21 14:41:38 volumio volumio[969]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 14:41:38 volumio volumio[969]: Error: dns service error: unknown Oct 21 14:41:38 volumio volumio[969]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 21 14:41:38 volumio volumio[969]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 21 14:41:38 volumio volumio[969]: errorCode: -65537 Oct 21 14:41:38 volumio volumio[969]: } Oct 21 14:41:38 volumio volumio[969]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 14:41:38 volumio sudo[6897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-21 14:40 Oct 21 14:41:38 volumio sudo[6897]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"