-- Logs begin at Tue 2025-07-01 03:09:10 UTC, end at Tue 2025-07-01 03:24:16 UTC. -- Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 21 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 22 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 20 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 27ms Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 66ms Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 64ms Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: 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":"loveclassics_64a","artist":"1.FM - Love Classics (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 91ms Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 87ms Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 87ms Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:01 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:01 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:01 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:01 volumio volumio[4263]: info: Jul 01 03:23:01 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 8ms Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 7 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 7ms Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":307,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Luther Vandross - Here and Now","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Luther Vandross - Here and Now","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 50ms Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 48ms Jul 01 03:23:01 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 45 milliseconds Jul 01 03:23:01 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:01 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:01 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:01 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Luther Vandross - Here and Now","artist":"1.FM - Love Classics Radio","album":null,"uri":"http://185.33.21.112:80/loveclassics_64a","trackType":""} Jul 01 03:23:01 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:01 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:01 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:01 volumio volumio[4263]: info: ------------------------------ 67ms Jul 01 03:23:17 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:17 volumio volumio[4263]: info: [1751340197908] ControllerWebradio::stop Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:17 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:17 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1852944 Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: [1751340197927] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand stop took 41 milliseconds Jul 01 03:23:17 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand stop took 21 milliseconds Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:17 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:17 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:17 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand clear took 4 milliseconds Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1852944" Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:17 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:17 volumio volumio[4263]: info: ------------------------------ 18ms Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:17 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:17 volumio volumio[4263]: info: Jul 01 03:23:17 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:17 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:17 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand status took 22 milliseconds Jul 01 03:23:17 volumio volumio[4263]: info: ------------------------------ 22ms Jul 01 03:23:17 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:17 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:17 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:17 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:17 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:17 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:17 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:17 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:17 volumio volumio[4263]: info: ------------------------------ 36ms Jul 01 03:23:17 volumio volumio[4263]: info: ------------------------------ 39ms Jul 01 03:23:18 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1852944" took 274 milliseconds Jul 01 03:23:18 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:18 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:18 volumio volumio[4263]: info: Jul 01 03:23:18 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:18 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:18 volumio volumio[4263]: info: ------------------------------ 263ms Jul 01 03:23:18 volumio volumio[4263]: info: ------------------------------ 264ms Jul 01 03:23:18 volumio volumio[4263]: info: sendMpdCommand play took 3 milliseconds Jul 01 03:23:18 volumio volumio[4263]: info: Jul 01 03:23:18 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:18 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:18 volumio volumio[4263]: info: Jul 01 03:23:18 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:18 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:18 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:23:18 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:18 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 25 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 24 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 23 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 52ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 75ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 76ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 48 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 48 milliseconds Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: 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":"smoothjazz_64a","artist":"1.FM - Bay Smooth Jazz (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 100ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 98ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 98ms Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 8ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:19 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:19 volumio volumio[4263]: info: Jul 01 03:23:19 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 8ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 6 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":392,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":733,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 68ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 67ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 66ms Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 56 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 56 milliseconds Jul 01 03:23:19 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 55 milliseconds Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:19 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:19 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Paul Hardcastle and the Jazzma - Without Love","artist":"1.FM - Bay Smooth Jazz Radio","album":null,"uri":"http://185.33.21.112:80/smoothjazz_64a","trackType":""} Jul 01 03:23:19 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:19 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:19 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 113ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 110ms Jul 01 03:23:19 volumio volumio[4263]: info: ------------------------------ 110ms Jul 01 03:23:22 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:22 volumio volumio[4263]: info: [1751340202280] ControllerWebradio::stop Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:22 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:22 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1747698 Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: [1751340202296] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand stop took 49 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand stop took 33 milliseconds Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:22 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:22 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand clear took 5 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1747698" Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:22 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:22 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:22 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:22 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 20ms Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 19ms Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:22 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 25ms Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1747698" took 244 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:22 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 230ms Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 229ms Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:22 volumio volumio[4263]: info: sendMpdCommand play took 2 milliseconds Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: info: Jul 01 03:23:22 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:22 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:22 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 29 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 32 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:24 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 43ms Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 52ms Jul 01 03:23:24 volumio volumio[4263]: info: Jul 01 03:23:24 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand status took 1 milliseconds Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:24 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:24 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:24 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 94ms Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 67ms Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 65ms Jul 01 03:23:24 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 01 03:23:24 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:24 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: 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":"ccountry_64a","artist":"1.FM - Classic Country (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:24 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:24 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:24 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:24 volumio volumio[4263]: info: ------------------------------ 72ms Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 10ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 8 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 8ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 7 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 7ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 7 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:25 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:25 volumio volumio[4263]: info: Jul 01 03:23:25 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 12ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 10 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 6 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":329,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":397,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 72ms Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 72ms Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 71ms Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 01 03:23:25 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 01 03:23:25 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:25 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:25 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Connie Smith - I Never Once Stopped Loving You","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Jul 01 03:23:25 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:25 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:25 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 125ms Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 119ms Jul 01 03:23:25 volumio volumio[4263]: info: ------------------------------ 118ms Jul 01 03:23:27 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:27 volumio volumio[4263]: info: [1751340207423] ControllerWebradio::stop Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:27 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:27 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1914279 Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: [1751340207436] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand stop took 46 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand stop took 33 milliseconds Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:27 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:27 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand clear took 2 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand status took 1 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1914279" Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:27 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:27 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:27 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:27 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 19ms Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 19ms Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 23ms Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:27 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 26ms Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1914279" took 243 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:27 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 227ms Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 223ms Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: info: Jul 01 03:23:27 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:27 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:27 volumio volumio[4263]: info: sendMpdCommand play took 3 milliseconds Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:27 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:28 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:28 volumio volumio[4263]: info: ------------------------------ 35ms Jul 01 03:23:28 volumio volumio[4263]: info: Jul 01 03:23:28 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:28 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:28 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:28 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:28 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:28 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:28 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:28 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:28 volumio volumio[4263]: info: ------------------------------ 82ms Jul 01 03:23:28 volumio volumio[4263]: info: ------------------------------ 86ms Jul 01 03:23:28 volumio volumio[4263]: info: ------------------------------ 59ms Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand status took 54 milliseconds Jul 01 03:23:28 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 01 03:23:28 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 84ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: 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":"top40_64a","artist":"1.FM - Absolute Top 40 (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 112ms Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:29 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:29 volumio volumio[4263]: info: Jul 01 03:23:29 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":193,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 69ms Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 71ms Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 72ms Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 65 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 65 milliseconds Jul 01 03:23:29 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 65 milliseconds Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:29 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:29 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Lady Gaga - How Bad Do U Want Me","artist":"1.FM - Absolute TOP 40 Radio","album":null,"uri":"http://185.33.21.112:80/top40_64a","trackType":""} Jul 01 03:23:29 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:29 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:29 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 126ms Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 125ms Jul 01 03:23:29 volumio volumio[4263]: info: ------------------------------ 125ms Jul 01 03:23:35 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:35 volumio volumio[4263]: info: [1751340215405] ControllerWebradio::stop Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:35 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:35 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1692022 Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: [1751340215423] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand stop took 35 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand stop took 14 milliseconds Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:35 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:35 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand clear took 3 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand status took 1 milliseconds Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1692022" Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:35 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:35 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:35 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:35 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 21ms Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 20ms Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 23ms Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:35 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 28ms Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1692022" took 214 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:35 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 198ms Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 197ms Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: info: Jul 01 03:23:35 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:35 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:35 volumio volumio[4263]: info: sendMpdCommand play took 4 milliseconds Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:35 volumio volumio[4263]: info: ------------------------------ 1ms Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 1 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 36ms Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 6 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 104ms Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 104ms Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 75ms Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 65 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 66 milliseconds Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: 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":"bossanova_64a","artist":"1.FM - Bossa Nova Hits (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 106ms Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 104ms Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:37 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:37 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:37 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:37 volumio volumio[4263]: info: Jul 01 03:23:37 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 8ms Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 6 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:37 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"ESTRELA GUIA - UN MONDO DI CERA","artist":"1.FM - Bossa Nova Hits Radio","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"ESTRELA GUIA - UN MONDO DI CERA","artist":"1.FM - Bossa Nova Hits Radio","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:37 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:37 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"ESTRELA GUIA - UN MONDO DI CERA","artist":"1.FM - Bossa Nova Hits Radio","album":null,"uri":"http://185.33.21.112:80/bossanova_64a","trackType":""} Jul 01 03:23:37 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:37 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:37 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 54ms Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 51ms Jul 01 03:23:37 volumio volumio[4263]: info: ------------------------------ 50ms Jul 01 03:23:45 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:45 volumio volumio[4263]: info: [1751340225589] ControllerWebradio::stop Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:45 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:45 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1803424 Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: [1751340225604] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand stop took 41 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand stop took 27 milliseconds Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:45 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:45 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand clear took 4 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1803424" Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:45 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 19ms Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand status took 24 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 23ms Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:45 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:45 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:45 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 41ms Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 227 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1803424" took 227 milliseconds Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:45 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:45 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:45 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 234ms Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 214ms Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 213ms Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:45 volumio volumio[4263]: info: sendMpdCommand play took 2 milliseconds Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: info: Jul 01 03:23:45 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:45 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:45 volumio volumio[4263]: info: ------------------------------ 1ms Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 29 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 28 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 47ms Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 66ms Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 65ms Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 38 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 80ms Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 77ms Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 43 milliseconds Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: 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":"blues_64","artist":"1.FM - Blues (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 103ms Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:47 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:47 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:47 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:47 volumio volumio[4263]: info: Jul 01 03:23:47 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 5 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 2ms Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:47 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Arnesen Blues Band - Mess Of Blues","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Arnesen Blues Band - Mess Of Blues","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:47 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:47 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Arnesen Blues Band - Mess Of Blues","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Jul 01 03:23:47 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:47 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:47 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 54ms Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 53ms Jul 01 03:23:47 volumio volumio[4263]: info: ------------------------------ 51ms Jul 01 03:23:49 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:23:49 volumio volumio[4263]: info: [1751340229066] ControllerWebradio::stop Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:23:49 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:23:49 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1859817 Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: [1751340229080] ControllerWebradio::clearAddPlayTrack Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand stop took 35 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand stop took 21 milliseconds Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:49 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:49 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand clear took 2 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1859817" Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:49 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:49 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:49 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:49 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 20ms Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 19ms Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 21ms Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:49 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 26ms Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1859817" took 260 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 242ms Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 241ms Jul 01 03:23:49 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:23:49 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: info: Jul 01 03:23:49 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:49 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:23:49 volumio volumio[4263]: info: sendMpdCommand play took 4 milliseconds Jul 01 03:23:49 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 29 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 28 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 44ms Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 53ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 21 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 93ms Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 64ms Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 63ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 44 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: 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":"ajazz_64a","artist":"1.FM - Adore Jazz","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 82ms Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:51 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:51 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:23:51 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:23:51 volumio volumio[4263]: info: Jul 01 03:23:51 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":250,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Silje Nergaard - What's New","artist":"1.FM - Adore Jazz Radio","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":261,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Silje Nergaard - What's New","artist":"1.FM - Adore Jazz Radio","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 33ms Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 32ms Jul 01 03:23:51 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 01 03:23:51 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:23:51 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:23:51 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:23:51 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":409,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Silje Nergaard - What's New","artist":"1.FM - Adore Jazz Radio","album":null,"uri":"http://185.33.21.112:80/ajazz_64a","trackType":""} Jul 01 03:23:51 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:23:51 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:23:51 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:23:51 volumio volumio[4263]: info: ------------------------------ 45ms Jul 01 03:24:00 volumio volumio[4263]: info: Saving local item radio-favourites Jul 01 03:24:00 volumio volumio[4263]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1859817","favourite":false} Jul 01 03:24:03 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::ClearQueue Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::stPlaybackTimer Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::serviceStop Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::serviceStop Jul 01 03:24:03 volumio volumio[4263]: info: [1751340243905] ControllerWebradio::stop Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::clearPlayQueue Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::addQueueItems Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::addQueueItems Jul 01 03:24:03 volumio volumio[4263]: info: Preload queue cleared Jul 01 03:24:03 volumio volumio[4263]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1889196 Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPushQueue Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::saveQueue Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::updateTrackBlock Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrackBlock Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPlay Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::play index 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::stop Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::play index undefined Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::startPlaybackTimer Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: [1751340243918] ControllerWebradio::clearAddPlayTrack Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand stop Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand stop took 35 milliseconds Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:03 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand stop took 22 milliseconds Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand clear Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:03 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:03 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:03 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand clear took 4 milliseconds Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1889196" Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:03 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:24:03 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:03 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:03 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:03 volumio volumio[4263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 01 03:24:03 volumio volumio[4263]: info: ------------------------------ 33ms Jul 01 03:24:03 volumio volumio[4263]: info: ------------------------------ 33ms Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:03 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:03 volumio volumio[4263]: info: Jul 01 03:24:03 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:03 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:03 volumio volumio[4263]: error: updateQueue error: null Jul 01 03:24:03 volumio volumio[4263]: info: ------------------------------ 38ms Jul 01 03:24:03 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 01 03:24:03 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:03 volumio volumio[4263]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 01 03:24:03 volumio volumio[4263]: info: ------------------------------ 43ms Jul 01 03:24:04 volumio volumio[4263]: info: Jul 01 03:24:04 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:04 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:04 volumio volumio[4263]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1889196" took 277 milliseconds Jul 01 03:24:04 volumio volumio[4263]: info: ------------------------------ 248ms Jul 01 03:24:04 volumio volumio[4263]: info: ------------------------------ 246ms Jul 01 03:24:04 volumio volumio[4263]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 01 03:24:04 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand play Jul 01 03:24:04 volumio volumio[4263]: info: Jul 01 03:24:04 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:04 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:04 volumio volumio[4263]: info: Jul 01 03:24:04 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:04 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:04 volumio volumio[4263]: info: ------------------------------ 9ms Jul 01 03:24:04 volumio volumio[4263]: info: sendMpdCommand play took 3 milliseconds Jul 01 03:24:04 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:24:04 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 30 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 31 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 2 milliseconds Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus stop Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:06 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:06 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 49ms Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 79ms Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 78ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 44 milliseconds Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:06 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:06 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: 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":"baroque_128","artist":"1.FM - Otto's Baroque Music (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:06 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:06 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:06 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 98ms Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 97ms Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 96ms Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 5ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces system playlist update Jul 01 03:24:06 volumio volumio[4263]: info: Ignoring MPD Status Update Jul 01 03:24:06 volumio volumio[4263]: info: Jul 01 03:24:06 volumio volumio[4263]: ---------------------------- MPD announces state update: player Jul 01 03:24:06 volumio volumio[4263]: info: ControllerMpd::getState Jul 01 03:24:06 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand status Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 6ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 6 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 4ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 4 milliseconds Jul 01 03:24:06 volumio volumio[4263]: info: ------------------------------ 3ms Jul 01 03:24:06 volumio volumio[4263]: info: sendMpdCommand status took 3 milliseconds Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseState Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":170,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":208,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":254,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ------------------------------ 77ms Jul 01 03:24:07 volumio volumio[4263]: info: ------------------------------ 76ms Jul 01 03:24:07 volumio volumio[4263]: info: ------------------------------ 79ms Jul 01 03:24:07 volumio volumio[4263]: info: sendMpdCommand playlistinfo took 67 milliseconds Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: verbose: ControllerMpd::parseTrackInfo Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ControllerMpd::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::servicePushState Jul 01 03:24:07 volumio volumio[4263]: info: CorePlayQueue::getTrack 0 Jul 01 03:24:07 volumio volumio[4263]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"COUPERIN, Louis - Leonhardt - Suite in a-II Allemande","artist":"1.FM - Otto's Baroque Music Radio","album":null,"uri":"http://185.33.21.112:80/baroque_128","trackType":""} Jul 01 03:24:07 volumio volumio[4263]: verbose: CURRENT POSITION 0 Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState stateService play Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::syncState currentStatus play Jul 01 03:24:07 volumio volumio[4263]: info: Received an update from plugin. extracting info from payload Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreStateMachine::pushState Jul 01 03:24:07 volumio volumio[4263]: info: CoreCommandRouter::volumioPushState Jul 01 03:24:07 volumio volumio[4263]: info: ------------------------------ 145ms Jul 01 03:24:07 volumio volumio[4263]: info: ------------------------------ 142ms Jul 01 03:24:14 volumio systemd[1]: Starting Cleanup of Temporary Directories... Jul 01 03:24:14 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Jul 01 03:24:14 volumio systemd[1]: Started Cleanup of Temporary Directories. Jul 01 03:24:16 volumio volumio[4263]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 03:24:16 volumio volumio[4263]: Error: connect ETIMEDOUT 104.244.46.5:80 Jul 01 03:24:16 volumio volumio[4263]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 01 03:24:16 volumio volumio[4263]: errno: -110, Jul 01 03:24:16 volumio volumio[4263]: code: 'ETIMEDOUT', Jul 01 03:24:16 volumio volumio[4263]: syscall: 'connect', Jul 01 03:24:16 volumio volumio[4263]: address: '104.244.46.5', Jul 01 03:24:16 volumio volumio[4263]: port: 80 Jul 01 03:24:16 volumio volumio[4263]: } Jul 01 03:24:16 volumio volumio[4263]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 03:24:16 volumio sudo[5245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-01 03:23 Jul 01 03:24:16 volumio sudo[5245]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"