Dec 29 17:38:00 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:00 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:00 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:00 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:00 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8 Dec 29 17:38:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:00 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:00 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:00 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:00 volumio volumio[1042]: info: [1767011880547] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:00 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:00 volumio volumio[1042]: info: sendMpdCommand stop took 3 milliseconds Dec 29 17:38:00 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:00 volumio volumio[1042]: info: Dec 29 17:38:00 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:00 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:00 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:38:00 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8" Dec 29 17:38:00 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:00 volumio volumio[1042]: info: Dec 29 17:38:00 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:00 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:00 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:00 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8" took 1 milliseconds Dec 29 17:38:00 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:00 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:00 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:00 volumio volumio[1042]: info: sendMpdCommand play took 0 milliseconds Dec 29 17:38:01 volumio volumio[1042]: info: Dec 29 17:38:01 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:01 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:01 volumio volumio[1042]: info: Dec 29 17:38:01 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:01 volumio volumio[1042]: info: sendMpdCommand status took 39 milliseconds Dec 29 17:38:01 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:01 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:38:01 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:01 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:01 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:01 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:01 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:01 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:01 volumio volumio[1042]: info: ------------------------------ 40ms Dec 29 17:38:01 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:01 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:01 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:01 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:01 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:01 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:01 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:01 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:01 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:01 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:01 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:01 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:01 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:01 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:38:05 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:05 volumio volumio[1042]: info: [1767011885305] ControllerWebradio::stop Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:05 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:05 volumio volumio[1042]: info: Adding Item to queue: http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8 Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:05 volumio volumio[1042]: info: [1767011885310] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:05 volumio volumio[1042]: info: Dec 29 17:38:05 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand stop took 11 milliseconds Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand stop took 6 milliseconds Dec 29 17:38:05 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:05 volumio volumio[1042]: info: Dec 29 17:38:05 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:05 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" Dec 29 17:38:05 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:05 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" took 0 milliseconds Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:05 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:05 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:05 volumio volumio[1042]: info: Dec 29 17:38:05 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:05 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:05 volumio volumio[1042]: info: sendMpdCommand play took 3 milliseconds Dec 29 17:38:05 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:08 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:08 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:08 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:08 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d96000.m3u8 Dec 29 17:38:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:08 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:08 volumio volumio[1042]: info: [1767011888917] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:08 volumio volumio[1042]: info: Dec 29 17:38:08 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:08 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:08 volumio volumio[1042]: info: Dec 29 17:38:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:08 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand clear took 0 milliseconds Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d96000.m3u8" Dec 29 17:38:08 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:08 volumio volumio[1042]: info: Dec 29 17:38:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:08 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:08 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d96000.m3u8" took 1 milliseconds Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:08 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:08 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:08 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:08 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:08 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:38:09 volumio volumio[1042]: info: Dec 29 17:38:09 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:09 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:09 volumio volumio[1042]: info: Dec 29 17:38:09 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:09 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:38:09 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:09 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:09 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:09 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:09 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:09 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d96000.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d96000.m3u8","trackType":"m3u8"} Dec 29 17:38:09 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:09 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:09 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:09 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:09 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:09 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:09 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d96000.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d96000.m3u8","trackType":"m3u8"} Dec 29 17:38:09 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:09 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:09 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:09 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:09 volumio volumio[1042]: info: ------------------------------ 9ms Dec 29 17:38:13 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:13 volumio volumio[1042]: info: [1767011893297] ControllerWebradio::stop Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:13 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:13 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8 Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: info: [1767011893304] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:13 volumio volumio[1042]: info: Dec 29 17:38:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand stop took 9 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:13 volumio volumio[1042]: info: Dec 29 17:38:13 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:13 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8" Dec 29 17:38:13 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:13 volumio volumio[1042]: info: Dec 29 17:38:13 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:13 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:13 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8" took 2 milliseconds Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:13 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:13 volumio volumio[1042]: info: ------------------------------ 5ms Dec 29 17:38:13 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: Dec 29 17:38:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:13 volumio volumio[1042]: info: Dec 29 17:38:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:13 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:13 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:13 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:13 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:13 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:13 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:13 volumio volumio[1042]: info: ------------------------------ 7ms Dec 29 17:38:26 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:26 volumio volumio[1042]: info: [1767011906583] ControllerWebradio::stop Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:26 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:26 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d128000.norewind.m3u8 Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: info: [1767011906592] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:26 volumio volumio[1042]: info: Dec 29 17:38:26 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand stop took 13 milliseconds Dec 29 17:38:26 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand stop took 4 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:26 volumio volumio[1042]: info: Dec 29 17:38:26 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:26 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d128000.norewind.m3u8" Dec 29 17:38:26 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:26 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:26 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:26 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:26 volumio volumio[1042]: info: Dec 29 17:38:26 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:26 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d128000.norewind.m3u8" took 0 milliseconds Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:26 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand play took 0 milliseconds Dec 29 17:38:26 volumio volumio[1042]: info: Dec 29 17:38:26 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:26 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:26 volumio volumio[1042]: info: Dec 29 17:38:26 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:26 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:26 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_fourfm-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:26 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:26 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:26 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:26 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:26 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_fourfm-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_55057080/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:26 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:26 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:26 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:26 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:26 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:26 volumio volumio[1042]: info: ------------------------------ 15ms Dec 29 17:38:29 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:29 volumio volumio[1042]: info: [1767011909608] ControllerWebradio::stop Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:29 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:29 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_26173715/live/ww/bbc_radio_four_extra/bbc_radio_four_extra.isml/bbc_radio_four_extra-audio%3d128000.norewind.m3u8 Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:29 volumio volumio[1042]: info: [1767011909618] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:29 volumio volumio[1042]: info: Dec 29 17:38:29 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand stop took 12 milliseconds Dec 29 17:38:29 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:29 volumio volumio[1042]: info: Dec 29 17:38:29 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:29 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand clear took 3 milliseconds Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_26173715/live/ww/bbc_radio_four_extra/bbc_radio_four_extra.isml/bbc_radio_four_extra-audio%3d128000.norewind.m3u8" Dec 29 17:38:29 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:29 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:29 volumio volumio[1042]: info: Dec 29 17:38:29 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:29 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_26173715/live/ww/bbc_radio_four_extra/bbc_radio_four_extra.isml/bbc_radio_four_extra-audio%3d128000.norewind.m3u8" took 0 milliseconds Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:29 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:29 volumio volumio[1042]: info: ------------------------------ 4ms Dec 29 17:38:29 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:29 volumio volumio[1042]: info: sendMpdCommand play took 3 milliseconds Dec 29 17:38:30 volumio volumio[1042]: info: Dec 29 17:38:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:30 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:30 volumio volumio[1042]: info: Dec 29 17:38:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:30 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:30 volumio volumio[1042]: info: sendMpdCommand status took 4 milliseconds Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:30 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:30 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:30 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_four_extra-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_26173715/live/ww/bbc_radio_four_extra/bbc_radio_four_extra.isml/bbc_radio_four_extra-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:30 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:38:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:30 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:30 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_four_extra-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_26173715/live/ww/bbc_radio_four_extra/bbc_radio_four_extra.isml/bbc_radio_four_extra-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:30 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:30 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:30 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:30 volumio volumio[1042]: info: ------------------------------ 9ms Dec 29 17:38:32 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:32 volumio volumio[1042]: info: [1767011912976] ControllerWebradio::stop Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:32 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:32 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_89021708/live/ww/bbc_radio_five_live/bbc_radio_five_live.isml/bbc_radio_five_live-audio%3d128000.norewind.m3u8 Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:32 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:32 volumio volumio[1042]: info: [1767011912982] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:32 volumio volumio[1042]: info: Dec 29 17:38:32 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand stop took 7 milliseconds Dec 29 17:38:32 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:32 volumio volumio[1042]: info: Dec 29 17:38:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:32 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand clear took 0 milliseconds Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_89021708/live/ww/bbc_radio_five_live/bbc_radio_five_live.isml/bbc_radio_five_live-audio%3d128000.norewind.m3u8" Dec 29 17:38:32 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:32 volumio volumio[1042]: info: Dec 29 17:38:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:32 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:32 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_89021708/live/ww/bbc_radio_five_live/bbc_radio_five_live.isml/bbc_radio_five_live-audio%3d128000.norewind.m3u8" took 1 milliseconds Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:32 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:32 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:32 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:32 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:32 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:38:33 volumio volumio[1042]: info: Dec 29 17:38:33 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:33 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:33 volumio volumio[1042]: info: Dec 29 17:38:33 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:33 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:33 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:33 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:33 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:33 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:33 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:33 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:33 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:33 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:33 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_five_live-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_89021708/live/ww/bbc_radio_five_live/bbc_radio_five_live.isml/bbc_radio_five_live-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:33 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:33 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:33 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:33 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:33 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_five_live-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_89021708/live/ww/bbc_radio_five_live/bbc_radio_five_live.isml/bbc_radio_five_live-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:33 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:33 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:33 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:33 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:33 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:33 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:33 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:33 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:38:33 volumio volumio[1042]: info: ------------------------------ 10ms Dec 29 17:38:35 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:35 volumio volumio[1042]: info: [1767011915048] ControllerWebradio::stop Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:35 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:35 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d320000.norewind.m3u8 Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: info: [1767011915054] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:35 volumio volumio[1042]: info: Dec 29 17:38:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand stop took 8 milliseconds Dec 29 17:38:35 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:35 volumio volumio[1042]: info: Dec 29 17:38:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:35 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d320000.norewind.m3u8" Dec 29 17:38:35 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:35 volumio volumio[1042]: info: Dec 29 17:38:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:35 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:35 volumio volumio[1042]: info: ------------------------------ 0ms Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d320000.norewind.m3u8" took 1 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:35 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:35 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:35 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand play took 0 milliseconds Dec 29 17:38:35 volumio volumio[1042]: info: Dec 29 17:38:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:35 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:35 volumio volumio[1042]: info: Dec 29 17:38:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:35 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:35 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d320000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d320000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:35 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:35 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:38:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:35 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d320000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d320000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:35 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:35 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:35 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:35 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:35 volumio volumio[1042]: info: ------------------------------ 7ms Dec 29 17:38:38 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:38 volumio volumio[1042]: info: [1767011918728] ControllerWebradio::stop Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:38 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:38 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8 Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:38 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:38 volumio volumio[1042]: info: [1767011918734] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:38 volumio volumio[1042]: info: Dec 29 17:38:38 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand stop took 9 milliseconds Dec 29 17:38:38 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand stop took 3 milliseconds Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:38 volumio volumio[1042]: info: Dec 29 17:38:38 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:38 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand clear took 3 milliseconds Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8" Dec 29 17:38:38 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:38 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8" took 1 milliseconds Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:38 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:38 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:38 volumio volumio[1042]: info: ------------------------------ 4ms Dec 29 17:38:38 volumio volumio[1042]: info: Dec 29 17:38:38 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:38 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:38 volumio volumio[1042]: info: sendMpdCommand play took 0 milliseconds Dec 29 17:38:38 volumio volumio[1042]: info: ------------------------------ 0ms Dec 29 17:38:39 volumio volumio[1042]: info: Dec 29 17:38:39 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:39 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:39 volumio volumio[1042]: info: Dec 29 17:38:39 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:39 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:39 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:39 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:38:39 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:39 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:39 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:39 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:39 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:39 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:39 volumio volumio[1042]: info: ------------------------------ 5ms Dec 29 17:38:39 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 29 17:38:39 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:39 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:39 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:39 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:39 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_6music-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_81827798/live/ww/bbc_6music/bbc_6music.isml/bbc_6music-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:39 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:39 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:39 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:39 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:39 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:39 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:39 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:39 volumio volumio[1042]: info: ------------------------------ 10ms Dec 29 17:38:41 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:38:41 volumio volumio[1042]: info: [1767011921008] ControllerWebradio::stop Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:38:41 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:38:41 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_53367543/live/ww/bbc_sounds_news/bbc_sounds_news.isml/bbc_sounds_news-audio%3d48000.norewind.m3u8 Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: info: [1767011921015] ControllerWebradio::clearAddPlayTrack Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:38:41 volumio volumio[1042]: info: Dec 29 17:38:41 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand stop took 9 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:38:41 volumio volumio[1042]: info: Dec 29 17:38:41 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:41 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand clear took 0 milliseconds Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_53367543/live/ww/bbc_sounds_news/bbc_sounds_news.isml/bbc_sounds_news-audio%3d48000.norewind.m3u8" Dec 29 17:38:41 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:38:41 volumio volumio[1042]: info: Dec 29 17:38:41 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:38:41 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:38:41 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_53367543/live/ww/bbc_sounds_news/bbc_sounds_news.isml/bbc_sounds_news-audio%3d48000.norewind.m3u8" took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:38:41 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:38:41 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:38:41 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: Dec 29 17:38:41 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:41 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:41 volumio volumio[1042]: info: Dec 29 17:38:41 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:41 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_sounds_news-audio%3d48000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_53367543/live/ww/bbc_sounds_news/bbc_sounds_news.isml/bbc_sounds_news-audio%3d48000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:41 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:38:41 volumio volumio[1042]: info: ------------------------------ 5ms Dec 29 17:38:41 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:38:41 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:38:41 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_sounds_news-audio%3d48000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_53367543/live/ww/bbc_sounds_news/bbc_sounds_news.isml/bbc_sounds_news-audio%3d48000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:38:41 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:38:41 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:41 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:41 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:38:41 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:38:41 volumio volumio[1042]: info: ------------------------------ 8ms Dec 29 17:39:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 29 17:39:00 volumio volumio[1042]: info: Getting BBC Radios Dec 29 17:39:00 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:05 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:39:05 volumio volumio[1042]: info: [1767011945974] ControllerWebradio::stop Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:39:05 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:05 volumio volumio[1042]: info: Adding Item to queue: https://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/audio_syndication_low_sbr_v1/aks/bbc_radio_one.m3u8 Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:05 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:39:05 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:05 volumio volumio[1042]: info: [1767011945983] ControllerWebradio::clearAddPlayTrack Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:05 volumio volumio[1042]: info: Dec 29 17:39:05 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand stop took 11 milliseconds Dec 29 17:39:05 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand stop took 2 milliseconds Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:39:05 volumio volumio[1042]: info: Dec 29 17:39:05 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:05 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand clear took 2 milliseconds Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "https://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/audio_syndication_low_sbr_v1/aks/bbc_radio_one.m3u8" Dec 29 17:39:05 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:39:05 volumio volumio[1042]: info: Dec 29 17:39:05 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:05 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:05 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand add "https://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/audio_syndication_low_sbr_v1/aks/bbc_radio_one.m3u8" took 1 milliseconds Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:05 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:39:05 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:39:05 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:39:05 volumio volumio[1042]: info: ------------------------------ 4ms Dec 29 17:39:05 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:05 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:39:09 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:09 volumio volumio[1042]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_43322914/live/ww/bbc_radio_scotland_fm/bbc_radio_scotland_fm.isml/bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8 Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:09 volumio volumio[1042]: info: [1767011949074] ControllerWebradio::clearAddPlayTrack Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:09 volumio volumio[1042]: info: Dec 29 17:39:09 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand stop took 4 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:39:09 volumio volumio[1042]: info: Dec 29 17:39:09 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:09 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_43322914/live/ww/bbc_radio_scotland_fm/bbc_radio_scotland_fm.isml/bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8" Dec 29 17:39:09 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:39:09 volumio volumio[1042]: info: ------------------------------ 0ms Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:09 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:39:09 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:09 volumio volumio[1042]: info: Dec 29 17:39:09 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:09 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_43322914/live/ww/bbc_radio_scotland_fm/bbc_radio_scotland_fm.isml/bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8" took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:39:09 volumio volumio[1042]: info: ------------------------------ 0ms Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand play took 0 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: Dec 29 17:39:09 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:09 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:09 volumio volumio[1042]: info: Dec 29 17:39:09 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:09 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:39:09 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:09 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:09 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:09 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_43322914/live/ww/bbc_radio_scotland_fm/bbc_radio_scotland_fm.isml/bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:39:09 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:39:09 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:09 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_43322914/live/ww/bbc_radio_scotland_fm/bbc_radio_scotland_fm.isml/bbc_radio_scotland_fm-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Dec 29 17:39:09 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:39:09 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:09 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:09 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:09 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:09 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:39:09 volumio volumio[1042]: info: ------------------------------ 10ms Dec 29 17:39:11 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:39:11 volumio volumio[1042]: info: [1767011951487] ControllerWebradio::stop Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:39:11 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:11 volumio volumio[1042]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:11 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:11 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:39:11 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:11 volumio volumio[1042]: info: [1767011951492] ControllerWebradio::clearAddPlayTrack Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:11 volumio volumio[1042]: info: Dec 29 17:39:11 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:11 volumio volumio[1042]: info: sendMpdCommand stop took 7 milliseconds Dec 29 17:39:11 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:11 volumio volumio[1042]: info: sendMpdCommand stop took 3 milliseconds Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:39:11 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:11 volumio volumio[1042]: info: Dec 29 17:39:11 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:11 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:11 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:39:11 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Dec 29 17:39:11 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:11 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:39:11 volumio volumio[1042]: info: ------------------------------ 4ms Dec 29 17:39:11 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:39:11 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:12 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Dec 29 17:39:12 volumio volumio[1042]: info: Dec 29 17:39:12 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:12 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:12 volumio volumio[1042]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 2 milliseconds Dec 29 17:39:12 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:39:12 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:39:12 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:12 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:39:13 volumio volumio[1042]: info: Dec 29 17:39:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand status took 9 milliseconds Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:13 volumio volumio[1042]: info: Dec 29 17:39:13 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:13 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:13 volumio volumio[1042]: info: Dec 29 17:39:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 29 17:39:13 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:13 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC Radio","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Dec 29 17:39:13 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:39:13 volumio volumio[1042]: info: ------------------------------ 13ms Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:13 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":461,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC Radio","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Dec 29 17:39:13 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:39:13 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:13 volumio volumio[1042]: info: ------------------------------ 7ms Dec 29 17:39:13 volumio volumio[1042]: info: Dec 29 17:39:13 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:13 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:13 volumio volumio[1042]: info: Dec 29 17:39:13 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:13 volumio volumio[1042]: info: ------------------------------ 5ms Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand status took 0 milliseconds Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:13 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 29 17:39:13 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:13 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:13 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:13 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC World Service Online","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Dec 29 17:39:13 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:39:13 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:13 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:13 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:39:14 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::serviceStop Dec 29 17:39:14 volumio volumio[1042]: info: [1767011954279] ControllerWebradio::stop Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 29 17:39:14 volumio volumio[1042]: info: Preload queue cleared Dec 29 17:39:14 volumio volumio[1042]: info: Adding Item to queue: https://vs-hls-push-ww-live.akamaized.net/x=4/i=urn:bbc:pips:service:bbc_news_channel_hd/t=3840/v=pv14/b=5070016/main.m3u8 Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::stop Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: info: [1767011954284] ControllerWebradio::clearAddPlayTrack Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 17:39:14 volumio volumio[1042]: info: Dec 29 17:39:14 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand stop took 8 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand stop took 4 milliseconds Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 17:39:14 volumio volumio[1042]: info: Dec 29 17:39:14 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:14 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "https://vs-hls-push-ww-live.akamaized.net/x=4/i=urn:bbc:pips:service:bbc_news_channel_hd/t=3840/v=pv14/b=5070016/main.m3u8" Dec 29 17:39:14 volumio volumio[1042]: error: updateQueue error: null Dec 29 17:39:14 volumio volumio[1042]: info: ------------------------------ 2ms Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:14 volumio volumio[1042]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 29 17:39:14 volumio volumio[1042]: info: ------------------------------ 3ms Dec 29 17:39:14 volumio volumio[1042]: info: Dec 29 17:39:14 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 29 17:39:14 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand add "https://vs-hls-push-ww-live.akamaized.net/x=4/i=urn:bbc:pips:service:bbc_news_channel_hd/t=3840/v=pv14/b=5070016/main.m3u8" took 2 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 29 17:39:14 volumio volumio[1042]: info: ------------------------------ 1ms Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand play took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: Dec 29 17:39:14 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:14 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:14 volumio volumio[1042]: info: Dec 29 17:39:14 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: ControllerMpd::getState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:14 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"main.m3u8","artist":null,"album":null,"uri":"https://vs-hls-push-ww-live.akamaized.net/x=4/i=urn:bbc:pips:service:bbc_news_channel_hd/t=3840/v=pv14/b=5070016/main.m3u8","trackType":"m3u8"} Dec 29 17:39:14 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 29 17:39:14 volumio volumio[1042]: info: ------------------------------ 4ms Dec 29 17:39:14 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 29 17:39:14 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 29 17:39:14 volumio volumio[1042]: info: ControllerMpd::pushState Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"main.m3u8","artist":null,"album":null,"uri":"https://vs-hls-push-ww-live.akamaized.net/x=4/i=urn:bbc:pips:service:bbc_news_channel_hd/t=3840/v=pv14/b=5070016/main.m3u8","trackType":"m3u8"} Dec 29 17:39:14 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 29 17:39:14 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:14 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:14 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 29 17:39:14 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 29 17:39:14 volumio volumio[1042]: info: ------------------------------ 6ms Dec 29 17:39:17 volumio volumio[1042]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 17:39:17 volumio volumio[1042]: Error Dec 29 17:39:17 volumio volumio[1042]: at /volumio/app/plugins/music_service/webradio/index.js:352:31 Dec 29 17:39:17 volumio volumio[1042]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15) Dec 29 17:39:17 volumio volumio[1042]: at self.callback (/volumio/node_modules/request/request.js:185:22) Dec 29 17:39:17 volumio volumio[1042]: at Request.emit (node:events:514:28) Dec 29 17:39:17 volumio volumio[1042]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8) Dec 29 17:39:17 volumio volumio[1042]: at ClientRequest.emit (node:events:514:28) Dec 29 17:39:17 volumio volumio[1042]: at Socket.socketErrorListener (node:_http_client:495:9) Dec 29 17:39:17 volumio volumio[1042]: at Socket.emit (node:events:514:28) Dec 29 17:39:17 volumio volumio[1042]: at emitErrorNT (node:internal/streams/destroy:151:8) Dec 29 17:39:17 volumio volumio[1042]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Dec 29 17:39:17 volumio volumio[1042]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Dec 29 17:39:17 volumio volumio[1042]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 17:39:17 volumio sudo[5998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-29 17:38' Dec 29 17:39:17 volumio sudo[5998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"