-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2025-03-10 23:26:24 CST. -- Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 19 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 20 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: 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":"dance_128","artist":"1.FM - Dance One (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 29ms Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: 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":"dance_128","artist":"1.FM - Dance One (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:03 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: 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":"dance_128","artist":"1.FM - Dance One (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:03 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 84ms Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 68ms Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 55 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: 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":"dance_128","artist":"1.FM - Dance One (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:03 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 94ms Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:03 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:03 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:03 volumio3 volumio[9652]: info: Mar 10 23:25:03 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 8ms Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 6 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 5ms Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand status took 4 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dimitri Vegas, Vin, Zion - Don’t Stop (The Music)","artist":"1.FM - Dance One Radio","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:03 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:03 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dimitri Vegas, Vin, Zion - Don’t Stop (The Music)","artist":"1.FM - Dance One Radio","album":null,"uri":"http://185.33.21.112:80/dance_128","trackType":""} Mar 10 23:25:03 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:03 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:03 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 63ms Mar 10 23:25:03 volumio3 volumio[9652]: info: ------------------------------ 60ms Mar 10 23:25:09 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::ClearQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::stPlaybackTimer Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::serviceStop Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::serviceStop Mar 10 23:25:09 volumio3 volumio[9652]: info: [1741620309062] ControllerWebradio::stop Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::clearPlayQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::addQueueItems Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::addQueueItems Mar 10 23:25:09 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:09 volumio3 volumio[9652]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPlay Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::play index 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::play index undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::startPlaybackTimer Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: [1741620309090] ControllerWebradio::clearAddPlayTrack Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand stop took 110 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand stop took 84 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:09 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:09 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand clear took 5 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343" Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:09 volumio3 volumio[9652]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 10 23:25:09 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:09 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:09 volumio3 volumio[9652]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 20ms Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 21ms Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:09 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:09 volumio3 volumio[9652]: error: updateQueue error: null Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 23ms Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:09 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343" took 258 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand play Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 243ms Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 5ms Mar 10 23:25:09 volumio3 volumio[9652]: info: sendMpdCommand play took 3 milliseconds Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:09 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:09 volumio3 volumio[9652]: info: ------------------------------ 2ms Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:09 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:09 volumio3 volumio[9652]: info: Mar 10 23:25:09 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:09 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:09 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:09 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 16 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 15 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: 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":"1992_128.mp3?fromyp=true","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: 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":"1992_128.mp3?fromyp=true","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:10 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 37ms Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 56ms Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: 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":"1992_128.mp3?fromyp=true","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:10 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 84ms Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 51 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: 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":"1992_128.mp3?fromyp=true","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:10 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 84ms Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:10 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:10 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:10 volumio3 volumio[9652]: info: Mar 10 23:25:10 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 8ms Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 5 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 5ms Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Buddy Guy - I Let My Guitar Do The Talking","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:10 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:10 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Buddy Guy - I Let My Guitar Do The Talking","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:10 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:10 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:10 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 63ms Mar 10 23:25:10 volumio3 volumio[9652]: info: ------------------------------ 60ms Mar 10 23:25:11 volumio3 volumio[9652]: info: Mar 10 23:25:11 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:11 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:11 volumio3 volumio[9652]: info: Mar 10 23:25:11 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:11 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:11 volumio3 volumio[9652]: info: Mar 10 23:25:11 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:11 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:11 volumio3 volumio[9652]: info: Mar 10 23:25:11 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:11 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:11 volumio3 volumio[9652]: info: ------------------------------ 6ms Mar 10 23:25:11 volumio3 volumio[9652]: info: sendMpdCommand status took 5 milliseconds Mar 10 23:25:11 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:25:11 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:11 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:11 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:11 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:11 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:11 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Smoke Wagon Blues Band - Matapedia River Blues","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:11 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:11 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:11 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:11 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Smoke Wagon Blues Band - Matapedia River Blues","artist":"BluesMusicFan Radio","album":null,"uri":"http://216.235.80.104:80/1992_128.mp3?fromyp=true","trackType":""} Mar 10 23:25:11 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:11 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:11 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:12 volumio3 volumio[9652]: info: ------------------------------ 56ms Mar 10 23:25:12 volumio3 volumio[9652]: info: ------------------------------ 54ms Mar 10 23:25:12 volumio3 volumio[9652]: info: Saving local item radio-favourites Mar 10 23:25:12 volumio3 volumio[9652]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1682343","favourite":false} Mar 10 23:25:18 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::ClearQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::stPlaybackTimer Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::serviceStop Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::serviceStop Mar 10 23:25:18 volumio3 volumio[9652]: info: [1741620318121] ControllerWebradio::stop Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::clearPlayQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::addQueueItems Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::addQueueItems Mar 10 23:25:18 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:18 volumio3 volumio[9652]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1416985 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPlay Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::play index 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::play index undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::startPlaybackTimer Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: [1741620318144] ControllerWebradio::clearAddPlayTrack Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand stop took 52 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand stop took 30 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:18 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:18 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand status took 6 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand clear took 4 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1416985" Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:18 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:18 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:18 volumio3 volumio[9652]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 25ms Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:18 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:18 volumio3 volumio[9652]: error: updateQueue error: null Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 27ms Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 24 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:18 volumio3 volumio[9652]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 35ms Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1416985" took 263 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 10 23:25:18 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand play Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:18 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 261ms Mar 10 23:25:18 volumio3 volumio[9652]: info: sendMpdCommand play took 18 milliseconds Mar 10 23:25:18 volumio3 volumio[9652]: info: Mar 10 23:25:18 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:18 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 5ms Mar 10 23:25:18 volumio3 volumio[9652]: info: ------------------------------ 2ms Mar 10 23:25:22 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 11 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 11 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: 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":"f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","artist":"(#1 - 147/1024) JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (West)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 19ms Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: 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":"f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","artist":"(#1 - 147/1024) JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (West)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: 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":"f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","artist":"(#1 - 147/1024) JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (West)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 78ms Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 70ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 59 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: 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":"f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","artist":"(#1 - 147/1024) JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (West)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 90ms Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:22 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:22 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:22 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 8ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 5 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:22 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:22 volumio3 volumio[9652]: info: Mar 10 23:25:22 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 11ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 11 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 10ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 8 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 7ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand status took 4 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rob Piltch - Witchcraft","artist":"Jazz Groove Mix 1 (Free FLAC)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 48ms Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rob Piltch - Witchcraft","artist":"Jazz Groove Mix 1 (Free FLAC)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rob Piltch - Witchcraft","artist":"Jazz Groove Mix 1 (Free FLAC)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:22 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rob Piltch - Witchcraft","artist":"Jazz Groove Mix 1 (Free FLAC)","album":null,"uri":"http://streams.radiomast.io:80/f0ac4bf3-bbe5-4edb-b828-193e0fdc4f2f","trackType":""} Mar 10 23:25:22 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:25:22 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:22 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 124ms Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 123ms Mar 10 23:25:22 volumio3 volumio[9652]: info: ------------------------------ 119ms Mar 10 23:25:35 volumio3 volumio[9652]: info: Saving local item radio-favourites Mar 10 23:25:35 volumio3 volumio[9652]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1416985","favourite":false} Mar 10 23:25:45 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::ClearQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::stPlaybackTimer Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::serviceStop Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::serviceStop Mar 10 23:25:45 volumio3 volumio[9652]: info: [1741620345228] ControllerWebradio::stop Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::clearPlayQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::addQueueItems Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::addQueueItems Mar 10 23:25:45 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:25:45 volumio3 volumio[9652]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540837 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPlay Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::play index 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::play index undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::startPlaybackTimer Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: [1741620345250] ControllerWebradio::clearAddPlayTrack Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand stop took 105 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:45 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand stop took 84 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:45 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:45 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand status took 4 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand clear took 3 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540837" Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:45 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:45 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:45 volumio3 volumio[9652]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 20ms Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:45 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:45 volumio3 volumio[9652]: error: updateQueue error: null Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 21ms Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:45 volumio3 volumio[9652]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 27ms Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540837" took 258 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 10 23:25:45 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand play Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:45 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 245ms Mar 10 23:25:45 volumio3 volumio[9652]: info: sendMpdCommand play took 3 milliseconds Mar 10 23:25:45 volumio3 volumio[9652]: info: Mar 10 23:25:45 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:25:45 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:25:45 volumio3 volumio[9652]: info: ------------------------------ 3ms Mar 10 23:25:47 volumio3 volumio[9652]: info: Mar 10 23:25:47 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:47 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:47 volumio3 volumio[9652]: info: Mar 10 23:25:47 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:25:47 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand status took 18 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand status took 18 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand clearerror took 15 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand clearerror took 14 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:47 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:25:47 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:47 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"Qfm Jazz","album":null,"uri":"http://51.91.82.7:5092/stream","trackType":""} Mar 10 23:25:47 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService stop Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: No code Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:25:47 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"Qfm Jazz","album":null,"uri":"http://51.91.82.7:5092/stream","trackType":""} Mar 10 23:25:47 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService stop Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: No code Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:25:47 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:25:47 volumio3 volumio[9652]: info: ------------------------------ 121ms Mar 10 23:25:47 volumio3 volumio[9652]: info: ------------------------------ 121ms Mar 10 23:26:06 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::ClearQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::clearPlayQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::addQueueItems Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::addQueueItems Mar 10 23:26:06 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:26:06 volumio3 volumio[9652]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669911 Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPlay Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::play index 0 Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::play index undefined Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::startPlaybackTimer Mar 10 23:26:06 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:06 volumio3 volumio[9652]: info: [1741620366049] ControllerWebradio::clearAddPlayTrack Mar 10 23:26:06 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:26:06 volumio3 volumio[9652]: info: sendMpdCommand stop took 7 milliseconds Mar 10 23:26:06 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 23:26:06 volumio3 volumio[9652]: info: Mar 10 23:26:06 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:06 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:06 volumio3 volumio[9652]: info: sendMpdCommand clear took 2 milliseconds Mar 10 23:26:06 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669911" Mar 10 23:26:06 volumio3 volumio[9652]: info: Mar 10 23:26:06 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:06 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:06 volumio3 volumio[9652]: error: updateQueue error: null Mar 10 23:26:06 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:26:06 volumio3 volumio[9652]: info: Mar 10 23:26:06 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:06 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:06 volumio3 volumio[9652]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669911" took 257 milliseconds Mar 10 23:26:06 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 10 23:26:06 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand play Mar 10 23:26:06 volumio3 volumio[9652]: info: ------------------------------ 258ms Mar 10 23:26:06 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:26:06 volumio3 volumio[9652]: info: sendMpdCommand play took 2 milliseconds Mar 10 23:26:06 volumio3 volumio[9652]: info: Mar 10 23:26:06 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:06 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:06 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 16 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 14 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 6 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: 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":"magic80_128","artist":"1.FM - Magic 80's (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 32ms Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: 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":"magic80_128","artist":"1.FM - Magic 80's (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:12 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: 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":"magic80_128","artist":"1.FM - Magic 80's (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:12 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 70ms Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 63ms Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 45 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: 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":"magic80_128","artist":"1.FM - Magic 80's (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:12 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 77ms Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:12 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:12 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:12 volumio3 volumio[9652]: info: Mar 10 23:26:12 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 5ms Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 5 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Scandal - Goodbye to You","artist":"1.FM - Magic 80 Radio","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:12 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:12 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Scandal - Goodbye to You","artist":"1.FM - Magic 80 Radio","album":null,"uri":"http://185.33.21.112:80/magic80_128","trackType":""} Mar 10 23:26:12 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:12 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:12 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:13 volumio3 volumio[9652]: info: ------------------------------ 58ms Mar 10 23:26:13 volumio3 volumio[9652]: info: ------------------------------ 56ms Mar 10 23:26:17 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::ClearQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::stPlaybackTimer Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::serviceStop Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::serviceStop Mar 10 23:26:17 volumio3 volumio[9652]: info: [1741620377423] ControllerWebradio::stop Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::clearPlayQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::addQueueItems Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::addQueueItems Mar 10 23:26:17 volumio3 volumio[9652]: info: Preload queue cleared Mar 10 23:26:17 volumio3 volumio[9652]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502708 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::saveQueue Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::updateTrackBlock Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrackBlock Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPlay Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::play index 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::stop Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::play index undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::startPlaybackTimer Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: [1741620377449] ControllerWebradio::clearAddPlayTrack Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand stop Mar 10 23:26:17 volumio3 volumio[9652]: info: Mar 10 23:26:17 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand stop took 42 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand stop took 15 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand clear Mar 10 23:26:17 volumio3 volumio[9652]: info: Mar 10 23:26:17 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:17 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand status took 3 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand clear took 2 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502708" Mar 10 23:26:17 volumio3 volumio[9652]: info: Mar 10 23:26:17 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:17 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:17 volumio3 volumio[9652]: error: updateQueue error: null Mar 10 23:26:17 volumio3 volumio[9652]: info: ------------------------------ 6ms Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:17 volumio3 volumio[9652]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 10 23:26:17 volumio3 volumio[9652]: info: ------------------------------ 11ms Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502708" took 253 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand play Mar 10 23:26:17 volumio3 volumio[9652]: info: Mar 10 23:26:17 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:17 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand status took 254 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:17 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:17 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 23:26:17 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService stop Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:17 volumio3 volumio[9652]: info: No code Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:17 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:17 volumio3 volumio[9652]: info: ------------------------------ 291ms Mar 10 23:26:17 volumio3 volumio[9652]: info: Mar 10 23:26:17 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:17 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:17 volumio3 volumio[9652]: info: sendMpdCommand play took 41 milliseconds Mar 10 23:26:17 volumio3 volumio[9652]: info: ------------------------------ 40ms Mar 10 23:26:17 volumio3 volumio[9652]: info: ------------------------------ 3ms Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 16 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 18 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 4 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: 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":"stream","artist":"(#1 - 55/250) Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus stop Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 26ms Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 7 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: 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":"stream","artist":"(#1 - 55/250) Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:19 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: 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":"stream","artist":"(#1 - 55/250) Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:19 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 78ms Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 65ms Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: 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":"stream","artist":"(#1 - 55/250) Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:19 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 88ms Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:19 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces system playlist update Mar 10 23:26:19 volumio3 volumio[9652]: info: Ignoring MPD Status Update Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 6ms Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 4ms Mar 10 23:26:19 volumio3 volumio[9652]: info: Mar 10 23:26:19 volumio3 volumio[9652]: ---------------------------- MPD announces state update: player Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::getState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand status Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 4 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand status took 2 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseState Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: verbose: ControllerMpd::parseTrackInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Jacksons - Shake Your Body (Down to the Ground)","artist":"Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:19 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: ControllerMpd::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::servicePushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CorePlayQueue::getTrack 0 Mar 10 23:26:19 volumio3 volumio[9652]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Jacksons - Shake Your Body (Down to the Ground)","artist":"Classic Hits 109 - 70s Hits!","album":null,"uri":"http://144.217.79.175:6980/stream","trackType":""} Mar 10 23:26:19 volumio3 volumio[9652]: verbose: CURRENT POSITION 0 Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState stateService play Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::syncState currentStatus play Mar 10 23:26:19 volumio3 volumio[9652]: info: Received an update from plugin. extracting info from payload Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreStateMachine::pushState Mar 10 23:26:19 volumio3 volumio[9652]: info: CoreCommandRouter::volumioPushState Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 71ms Mar 10 23:26:19 volumio3 volumio[9652]: info: ------------------------------ 68ms Mar 10 23:26:23 volumio3 volumio[9652]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 23:26:23 volumio3 volumio[9652]: Error: connect ETIMEDOUT 43.226.16.8:80 Mar 10 23:26:23 volumio3 volumio[9652]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 10 23:26:23 volumio3 volumio[9652]: errno: -110, Mar 10 23:26:23 volumio3 volumio[9652]: code: 'ETIMEDOUT', Mar 10 23:26:23 volumio3 volumio[9652]: syscall: 'connect', Mar 10 23:26:23 volumio3 volumio[9652]: address: '43.226.16.8', Mar 10 23:26:23 volumio3 volumio[9652]: port: 80 Mar 10 23:26:23 volumio3 volumio[9652]: } Mar 10 23:26:23 volumio3 volumio[9652]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 23:26:24 volumio3 sudo[9887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 23:25 Mar 10 23:26:24 volumio3 sudo[9887]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"