-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-05-28 23:17:28 CEST. -- May 28 23:16:08 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: calmradio , handleBrowseUri May 28 23:16:08 volumio volumio[859]: info: Calm Radio group browse calmradio://16/46 May 28 23:16:08 volumio volumio[859]: info: Calm Radio list channels for group 46 May 28 23:16:08 volumio volumio[859]: info: Preload queue cleared May 28 23:16:11 volumio volumio[859]: info: Preload queue cleared May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:11 volumio volumio[859]: info: [1748466971759] ControllerCalmRadio::stop May 28 23:16:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:11 volumio volumio[859]: info: Preload queue cleared May 28 23:16:11 volumio volumio[859]: info: Adding Item to queue: calmradio://46/241 May 28 23:16:11 volumio volumio[859]: info: Exploding uri calmradio://46/241 in service calmradio May 28 23:16:11 volumio volumio[859]: info: Calm Radio explodeUri for Cat 46 Chan 241 May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:11 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:11 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:11 volumio volumio[859]: info: [1748466971879] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:11 volumio volumio[859]: { May 28 23:16:11 volumio volumio[859]: uri: 'calmradio://46/241', May 28 23:16:11 volumio volumio[859]: service: 'calmradio', May 28 23:16:11 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:11 volumio volumio[859]: radioType: 'web', May 28 23:16:11 volumio volumio[859]: name: 'EARTH', May 28 23:16:11 volumio volumio[859]: title: 'EARTH', May 28 23:16:11 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/241/5bb6f866718ab90777d9d8c48a1b9d3acd2f1cd19179c6596c96d556a0b6.png', May 28 23:16:11 volumio volumio[859]: type: 'webradio', May 28 23:16:11 volumio volumio[859]: samplerate: '', May 28 23:16:11 volumio volumio[859]: bitdepth: 0, May 28 23:16:11 volumio volumio[859]: channels: 0 May 28 23:16:11 volumio volumio[859]: } May 28 23:16:11 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 46 Chan 241 May 28 23:16:11 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/6352/128/stream May 28 23:16:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:11 volumio volumio[859]: info: May 28 23:16:11 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:11 volumio volumio[859]: info: sendMpdCommand stop took 236 milliseconds May 28 23:16:11 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:11 volumio volumio[859]: info: sendMpdCommand stop took 7 milliseconds May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:12 volumio volumio[859]: info: May 28 23:16:12 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:12 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:12 volumio volumio[859]: info: sendMpdCommand status took 17 milliseconds May 28 23:16:12 volumio volumio[859]: info: sendMpdCommand clear took 18 milliseconds May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/6352/128/stream" May 28 23:16:12 volumio volumio[859]: error: updateQueue error: null May 28 23:16:12 volumio volumio[859]: info: May 28 23:16:12 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:12 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:12 volumio volumio[859]: info: ------------------------------ 6ms May 28 23:16:12 volumio volumio[859]: info: sendMpdCommand playlistinfo took 4 milliseconds May 28 23:16:12 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/6352/128/stream" took 4 milliseconds May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:12 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:12 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:12 volumio volumio[859]: info: ------------------------------ 28ms May 28 23:16:12 volumio volumio[859]: info: May 28 23:16:12 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:12 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:12 volumio volumio[859]: info: ------------------------------ 8ms May 28 23:16:12 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:12 volumio volumio[859]: info: ------------------------------ 4ms May 28 23:16:12 volumio volumio[859]: info: sendMpdCommand play took 2 milliseconds May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand status took 3 milliseconds May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:13 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:13 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"EARTH","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/6352/128/stream","trackType":""} May 28 23:16:13 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 6ms May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:13 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:13 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"EARTH","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/6352/128/stream","trackType":""} May 28 23:16:13 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:13 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 11ms May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:13 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:13 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:13 volumio volumio[859]: info: May 28 23:16:13 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 4ms May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:13 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:13 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - Atmospheres - Earth - Sampler","artist":"CALM RADIO - EARTH","album":null,"uri":"https://streams.calmradio.com/api/6352/128/stream","trackType":""} May 28 23:16:13 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:13 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 10ms May 28 23:16:13 volumio volumio[859]: info: sendMpdCommand playlistinfo took 7 milliseconds May 28 23:16:13 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:13 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:13 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:13 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - Atmospheres - Earth - Sampler","artist":"CALM RADIO - EARTH","album":null,"uri":"https://streams.calmradio.com/api/6352/128/stream","trackType":""} May 28 23:16:13 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:13 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:13 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:13 volumio volumio[859]: info: ------------------------------ 16ms May 28 23:16:18 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: calmradio , handleBrowseUri May 28 23:16:18 volumio volumio[859]: info: Calm Radio group browse calmradio://46/-1 May 28 23:16:18 volumio volumio[859]: info: Calm Radio list channels for group -1 May 28 23:16:26 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: calmradio , handleBrowseUri May 28 23:16:26 volumio volumio[859]: info: Calm Radio group browse calmradio://2/56 May 28 23:16:26 volumio volumio[859]: info: Calm Radio list channels for group 56 May 28 23:16:26 volumio volumio[859]: info: Preload queue cleared May 28 23:16:28 volumio volumio[859]: info: Preload queue cleared May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:28 volumio volumio[859]: info: [1748466988801] ControllerCalmRadio::stop May 28 23:16:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:28 volumio volumio[859]: info: Preload queue cleared May 28 23:16:28 volumio volumio[859]: info: Adding Item to queue: calmradio://56/926 May 28 23:16:28 volumio volumio[859]: info: Exploding uri calmradio://56/926 in service calmradio May 28 23:16:28 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 926 May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:28 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:28 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:28 volumio volumio[859]: info: [1748466988901] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:28 volumio volumio[859]: { May 28 23:16:28 volumio volumio[859]: uri: 'calmradio://56/926', May 28 23:16:28 volumio volumio[859]: service: 'calmradio', May 28 23:16:28 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:28 volumio volumio[859]: radioType: 'web', May 28 23:16:28 volumio volumio[859]: name: 'MY BEST SLEEP EVER', May 28 23:16:28 volumio volumio[859]: title: 'MY BEST SLEEP EVER', May 28 23:16:28 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/926/66cbc9ccd9112e847a33e23b2ae07225e702d12dde8d9b7438e535de91fa.png', May 28 23:16:28 volumio volumio[859]: type: 'webradio', May 28 23:16:28 volumio volumio[859]: samplerate: '', May 28 23:16:28 volumio volumio[859]: bitdepth: 0, May 28 23:16:28 volumio volumio[859]: channels: 0 May 28 23:16:28 volumio volumio[859]: } May 28 23:16:28 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 926 May 28 23:16:28 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/4582/128/stream May 28 23:16:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:28 volumio volumio[859]: info: May 28 23:16:28 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:28 volumio volumio[859]: info: sendMpdCommand stop took 197 milliseconds May 28 23:16:28 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:28 volumio volumio[859]: info: sendMpdCommand stop took 7 milliseconds May 28 23:16:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:29 volumio volumio[859]: info: May 28 23:16:29 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:29 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:29 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:29 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds May 28 23:16:29 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/4582/128/stream" May 28 23:16:29 volumio volumio[859]: error: updateQueue error: null May 28 23:16:29 volumio volumio[859]: info: May 28 23:16:29 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:29 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:29 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:29 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:29 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/4582/128/stream" took 2 milliseconds May 28 23:16:29 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:29 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:29 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:29 volumio volumio[859]: info: ------------------------------ 6ms May 28 23:16:29 volumio volumio[859]: info: May 28 23:16:29 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:29 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:29 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:29 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:29 volumio volumio[859]: info: ------------------------------ 1ms May 28 23:16:29 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds May 28 23:16:29 volumio volumio[859]: info: [1748466989173] [80s80s] Pushing the next song state Beverley Knight - Flavour of the Old School and getting next track. May 28 23:16:29 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:29 volumio volumio[859]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received 80s80s May 28 23:16:29 volumio volumio[859]: info: [1748466989176] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=266&count=1 May 28 23:16:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:29 volumio volumio[859]: info: Prefetching next song May 28 23:16:29 volumio volumio[859]: info: [1748466989365] [80s80s] received new event containing 1 songs. May 28 23:16:29 volumio volumio[859]: info: [1748466989366] [80s80s] PlayNextTrack API delay: 30 May 28 23:16:29 volumio volumio[859]: info: [1748466989374] [80s80s] Setting timer to: 235000 milliseconds. May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand status took 0 milliseconds May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:30 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MY BEST SLEEP EVER","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/4582/128/stream","trackType":""} May 28 23:16:30 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 5ms May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:30 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"MY BEST SLEEP EVER","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/4582/128/stream","trackType":""} May 28 23:16:30 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:30 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 10ms May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:30 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:30 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:30 volumio volumio[859]: info: May 28 23:16:30 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:30 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rebecca Reads - - - Drifting Into Sleep Delta Wave","artist":"MY BEST SLEEP EVER - ROYALTY FREE - sampler","album":null,"uri":"https://streams.calmradio.com/api/4582/128/stream","trackType":""} May 28 23:16:30 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:30 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 11ms May 28 23:16:30 volumio volumio[859]: info: sendMpdCommand playlistinfo took 7 milliseconds May 28 23:16:30 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:30 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:30 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:30 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rebecca Reads - - - Drifting Into Sleep Delta Wave","artist":"MY BEST SLEEP EVER - ROYALTY FREE - sampler","album":null,"uri":"https://streams.calmradio.com/api/4582/128/stream","trackType":""} May 28 23:16:30 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:30 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:30 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:30 volumio volumio[859]: info: ------------------------------ 16ms May 28 23:16:32 volumio volumio[859]: info: Preload queue cleared May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:32 volumio volumio[859]: info: [1748466992061] ControllerCalmRadio::stop May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:32 volumio volumio[859]: info: Preload queue cleared May 28 23:16:32 volumio volumio[859]: info: Adding Item to queue: calmradio://56/608 May 28 23:16:32 volumio volumio[859]: info: Exploding uri calmradio://56/608 in service calmradio May 28 23:16:32 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 608 May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:32 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:32 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:32 volumio volumio[859]: info: [1748466992157] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:32 volumio volumio[859]: { May 28 23:16:32 volumio volumio[859]: uri: 'calmradio://56/608', May 28 23:16:32 volumio volumio[859]: service: 'calmradio', May 28 23:16:32 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:32 volumio volumio[859]: radioType: 'web', May 28 23:16:32 volumio volumio[859]: name: 'CELLO FOR SLEEP', May 28 23:16:32 volumio volumio[859]: title: 'CELLO FOR SLEEP', May 28 23:16:32 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/608/889c3f26a559d72318811a4c9abb92b56c6a7d1b159297761a35f97efb83.png', May 28 23:16:32 volumio volumio[859]: type: 'webradio', May 28 23:16:32 volumio volumio[859]: samplerate: '', May 28 23:16:32 volumio volumio[859]: bitdepth: 0, May 28 23:16:32 volumio volumio[859]: channels: 0 May 28 23:16:32 volumio volumio[859]: } May 28 23:16:32 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 608 May 28 23:16:32 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/2018/128/stream May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:32 volumio volumio[859]: info: May 28 23:16:32 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand stop took 194 milliseconds May 28 23:16:32 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand stop took 4 milliseconds May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:32 volumio volumio[859]: info: May 28 23:16:32 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:32 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2018/128/stream" May 28 23:16:32 volumio volumio[859]: error: updateQueue error: null May 28 23:16:32 volumio volumio[859]: info: May 28 23:16:32 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:32 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:32 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2018/128/stream" took 2 milliseconds May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:32 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:32 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:32 volumio volumio[859]: info: ------------------------------ 6ms May 28 23:16:32 volumio volumio[859]: info: May 28 23:16:32 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:32 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:32 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:32 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:32 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:32 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:32 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds May 28 23:16:33 volumio volumio[859]: info: May 28 23:16:33 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:33 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:33 volumio volumio[859]: info: May 28 23:16:33 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:33 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:33 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:33 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:33 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:33 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:33 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:33 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:33 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CELLO FOR SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2018/128/stream","trackType":""} May 28 23:16:33 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:33 volumio volumio[859]: info: ------------------------------ 10ms May 28 23:16:33 volumio volumio[859]: info: sendMpdCommand playlistinfo took 3 milliseconds May 28 23:16:33 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:33 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:33 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:33 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:33 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CELLO FOR SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2018/128/stream","trackType":""} May 28 23:16:33 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:33 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:33 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:33 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:33 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:33 volumio volumio[859]: info: ------------------------------ 15ms May 28 23:16:34 volumio volumio[859]: info: Preload queue cleared May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:34 volumio volumio[859]: info: [1748466994559] ControllerCalmRadio::stop May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:34 volumio volumio[859]: info: Preload queue cleared May 28 23:16:34 volumio volumio[859]: info: Adding Item to queue: calmradio://56/648 May 28 23:16:34 volumio volumio[859]: info: Exploding uri calmradio://56/648 in service calmradio May 28 23:16:34 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 648 May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:34 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:34 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:34 volumio volumio[859]: info: [1748466994658] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:34 volumio volumio[859]: { May 28 23:16:34 volumio volumio[859]: uri: 'calmradio://56/648', May 28 23:16:34 volumio volumio[859]: service: 'calmradio', May 28 23:16:34 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:34 volumio volumio[859]: radioType: 'web', May 28 23:16:34 volumio volumio[859]: name: 'WHISPERING ANGEL', May 28 23:16:34 volumio volumio[859]: title: 'WHISPERING ANGEL', May 28 23:16:34 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/648/b1dc9d5f53c9acaed56f8e56265089cfa927c1d1ec418e1222060132f661.png', May 28 23:16:34 volumio volumio[859]: type: 'webradio', May 28 23:16:34 volumio volumio[859]: samplerate: '', May 28 23:16:34 volumio volumio[859]: bitdepth: 0, May 28 23:16:34 volumio volumio[859]: channels: 0 May 28 23:16:34 volumio volumio[859]: } May 28 23:16:34 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 648 May 28 23:16:34 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/2262/128/stream May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:34 volumio volumio[859]: info: May 28 23:16:34 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand stop took 194 milliseconds May 28 23:16:34 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand stop took 4 milliseconds May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:34 volumio volumio[859]: info: May 28 23:16:34 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:34 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2262/128/stream" May 28 23:16:34 volumio volumio[859]: error: updateQueue error: null May 28 23:16:34 volumio volumio[859]: info: May 28 23:16:34 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:34 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:34 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2262/128/stream" took 1 milliseconds May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:34 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:34 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:34 volumio volumio[859]: info: ------------------------------ 5ms May 28 23:16:34 volumio volumio[859]: info: May 28 23:16:34 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:34 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:34 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:34 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:34 volumio volumio[859]: info: ------------------------------ 1ms May 28 23:16:34 volumio volumio[859]: info: sendMpdCommand play took 0 milliseconds May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand status took 3 milliseconds May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:35 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:35 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"WHISPERING ANGEL","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2262/128/stream","trackType":""} May 28 23:16:35 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 7ms May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:35 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:35 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"WHISPERING ANGEL","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2262/128/stream","trackType":""} May 28 23:16:35 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:35 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 11ms May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:35 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:35 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:35 volumio volumio[859]: info: May 28 23:16:35 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:35 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:35 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":280,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Eric Harry - Binaural Sleep - Whispering Angels","artist":"CALMRADIO.COM - Whispering Angel","album":null,"uri":"https://streams.calmradio.com/api/2262/128/stream","trackType":""} May 28 23:16:35 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:35 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 11ms May 28 23:16:35 volumio volumio[859]: info: sendMpdCommand playlistinfo took 7 milliseconds May 28 23:16:35 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:35 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:35 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:35 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Eric Harry - Binaural Sleep - Whispering Angels","artist":"CALMRADIO.COM - Whispering Angel","album":null,"uri":"https://streams.calmradio.com/api/2262/128/stream","trackType":""} May 28 23:16:35 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:35 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:35 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:35 volumio volumio[859]: info: ------------------------------ 16ms May 28 23:16:38 volumio volumio[859]: info: Preload queue cleared May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:38 volumio volumio[859]: info: [1748466998147] ControllerCalmRadio::stop May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:38 volumio volumio[859]: info: Preload queue cleared May 28 23:16:38 volumio volumio[859]: info: Adding Item to queue: calmradio://56/688 May 28 23:16:38 volumio volumio[859]: info: Exploding uri calmradio://56/688 in service calmradio May 28 23:16:38 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 688 May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:38 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:38 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:38 volumio volumio[859]: info: [1748466998258] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:38 volumio volumio[859]: { May 28 23:16:38 volumio volumio[859]: uri: 'calmradio://56/688', May 28 23:16:38 volumio volumio[859]: service: 'calmradio', May 28 23:16:38 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:38 volumio volumio[859]: radioType: 'web', May 28 23:16:38 volumio volumio[859]: name: 'FLYING DREAMS', May 28 23:16:38 volumio volumio[859]: title: 'FLYING DREAMS', May 28 23:16:38 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/688/136886d57ea5054e2c6757b9a8e781769c372f651d694705e3547b70c480.png', May 28 23:16:38 volumio volumio[859]: type: 'webradio', May 28 23:16:38 volumio volumio[859]: samplerate: '', May 28 23:16:38 volumio volumio[859]: bitdepth: 0, May 28 23:16:38 volumio volumio[859]: channels: 0 May 28 23:16:38 volumio volumio[859]: } May 28 23:16:38 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 688 May 28 23:16:38 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/2436/128/stream May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:38 volumio volumio[859]: info: May 28 23:16:38 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand stop took 208 milliseconds May 28 23:16:38 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand stop took 8 milliseconds May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:38 volumio volumio[859]: info: May 28 23:16:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:38 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand status took 3 milliseconds May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand clear took 4 milliseconds May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2436/128/stream" May 28 23:16:38 volumio volumio[859]: error: updateQueue error: null May 28 23:16:38 volumio volumio[859]: info: May 28 23:16:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:38 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:38 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2436/128/stream" took 2 milliseconds May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:38 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:38 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:38 volumio volumio[859]: info: ------------------------------ 8ms May 28 23:16:38 volumio volumio[859]: info: May 28 23:16:38 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:38 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:38 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:38 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:38 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:38 volumio volumio[859]: info: ------------------------------ 1ms May 28 23:16:38 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds May 28 23:16:39 volumio volumio[859]: info: May 28 23:16:39 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:39 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:39 volumio volumio[859]: info: May 28 23:16:39 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:39 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:39 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:39 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:39 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:39 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:39 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:39 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:39 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"FLYING DREAMS","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2436/128/stream","trackType":""} May 28 23:16:39 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:39 volumio volumio[859]: info: ------------------------------ 5ms May 28 23:16:39 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:39 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:39 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:39 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:39 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:39 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"FLYING DREAMS","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2436/128/stream","trackType":""} May 28 23:16:39 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:39 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:39 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:39 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:39 volumio volumio[859]: info: ------------------------------ 9ms May 28 23:16:41 volumio volumio[859]: info: Preload queue cleared May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:41 volumio volumio[859]: info: [1748467001860] ControllerCalmRadio::stop May 28 23:16:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:41 volumio volumio[859]: info: Preload queue cleared May 28 23:16:41 volumio volumio[859]: info: Adding Item to queue: calmradio://56/600 May 28 23:16:41 volumio volumio[859]: info: Exploding uri calmradio://56/600 in service calmradio May 28 23:16:41 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 600 May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:41 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:41 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:41 volumio volumio[859]: info: [1748467001959] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:41 volumio volumio[859]: { May 28 23:16:41 volumio volumio[859]: uri: 'calmradio://56/600', May 28 23:16:41 volumio volumio[859]: service: 'calmradio', May 28 23:16:41 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:41 volumio volumio[859]: radioType: 'web', May 28 23:16:41 volumio volumio[859]: name: 'DEEP SLEEP', May 28 23:16:41 volumio volumio[859]: title: 'DEEP SLEEP', May 28 23:16:41 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/600/73852d1e27ca81760f1db8e2c044ee388527f95f57edf899131563337e4d.png', May 28 23:16:41 volumio volumio[859]: type: 'webradio', May 28 23:16:41 volumio volumio[859]: samplerate: '', May 28 23:16:41 volumio volumio[859]: bitdepth: 0, May 28 23:16:41 volumio volumio[859]: channels: 0 May 28 23:16:41 volumio volumio[859]: } May 28 23:16:41 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 600 May 28 23:16:42 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/2034/128/stream May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:42 volumio volumio[859]: info: May 28 23:16:42 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand stop took 198 milliseconds May 28 23:16:42 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand stop took 4 milliseconds May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:42 volumio volumio[859]: info: May 28 23:16:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:42 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2034/128/stream" May 28 23:16:42 volumio volumio[859]: error: updateQueue error: null May 28 23:16:42 volumio volumio[859]: info: May 28 23:16:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:42 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:42 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2034/128/stream" took 1 milliseconds May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:42 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:42 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:42 volumio volumio[859]: info: ------------------------------ 5ms May 28 23:16:42 volumio volumio[859]: info: May 28 23:16:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:42 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:42 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:42 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:42 volumio volumio[859]: info: ------------------------------ 1ms May 28 23:16:42 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 0 milliseconds May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"DEEP SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2034/128/stream","trackType":""} May 28 23:16:43 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 7ms May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"DEEP SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2034/128/stream","trackType":""} May 28 23:16:43 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:43 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 10ms May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:43 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:43 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:43 volumio volumio[859]: info: May 28 23:16:43 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 1ms May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":852,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Advert: - Limited Time Offer - Save on monthly, 1 Year and 2 Year Memberships - Advert:","artist":"CALMRADIO.COM - Deep Sleep","album":null,"uri":"https://streams.calmradio.com/api/2034/128/stream","trackType":""} May 28 23:16:43 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:43 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Advert: - Limited Time Offer - Save on monthly, 1 Year and 2 Year Memberships - Advert:","artist":"CALMRADIO.COM - Deep Sleep","album":null,"uri":"https://streams.calmradio.com/api/2034/128/stream","trackType":""} May 28 23:16:43 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:43 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 15ms May 28 23:16:43 volumio volumio[859]: info: ------------------------------ 14ms May 28 23:16:45 volumio volumio[859]: info: Preload queue cleared May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::ClearQueue May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:16:45 volumio volumio[859]: info: [1748467005175] ControllerCalmRadio::stop May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::addQueueItems May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::addQueueItems May 28 23:16:45 volumio volumio[859]: info: Preload queue cleared May 28 23:16:45 volumio volumio[859]: info: Adding Item to queue: calmradio://56/766 May 28 23:16:45 volumio volumio[859]: info: Exploding uri calmradio://56/766 in service calmradio May 28 23:16:45 volumio volumio[859]: info: Calm Radio explodeUri for Cat 56 Chan 766 May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::saveQueue May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:16:45 volumio volumio[859]: info: CoreCommandRouter::volumioPlay May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::play index 0 May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::play index undefined May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:45 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:45 volumio volumio[859]: info: [1748467005274] ControllerCalmRadio::clearAddPlayTrack May 28 23:16:45 volumio volumio[859]: { May 28 23:16:45 volumio volumio[859]: uri: 'calmradio://56/766', May 28 23:16:45 volumio volumio[859]: service: 'calmradio', May 28 23:16:45 volumio volumio[859]: trackType: 'CalmRadio', May 28 23:16:45 volumio volumio[859]: radioType: 'web', May 28 23:16:45 volumio volumio[859]: name: 'CELLO MOON', May 28 23:16:45 volumio volumio[859]: title: 'CELLO MOON', May 28 23:16:45 volumio volumio[859]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/766/c291171077ff04a41f2cf86aede36d17745f0fc36246c710c52d5bec1129.png', May 28 23:16:45 volumio volumio[859]: type: 'webradio', May 28 23:16:45 volumio volumio[859]: samplerate: '', May 28 23:16:45 volumio volumio[859]: bitdepth: 0, May 28 23:16:45 volumio volumio[859]: channels: 0 May 28 23:16:45 volumio volumio[859]: } May 28 23:16:45 volumio volumio[859]: info: Calm Radio getStreamUrl for Cat 56 Chan 766 May 28 23:16:45 volumio volumio[859]: STREAMURL: https://streams.calmradio.com/api/2626/128/stream May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop May 28 23:16:45 volumio volumio[859]: info: May 28 23:16:45 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand stop took 193 milliseconds May 28 23:16:45 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand stop took 4 milliseconds May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear May 28 23:16:45 volumio volumio[859]: info: May 28 23:16:45 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:45 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand clear took 1 milliseconds May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2626/128/stream" May 28 23:16:45 volumio volumio[859]: error: updateQueue error: null May 28 23:16:45 volumio volumio[859]: info: May 28 23:16:45 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:45 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:45 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2626/128/stream" took 2 milliseconds May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:45 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 28 23:16:45 volumio volumio[859]: verbose: MPD COMMAND [object Object] May 28 23:16:45 volumio volumio[859]: info: ------------------------------ 5ms May 28 23:16:45 volumio volumio[859]: info: May 28 23:16:45 volumio volumio[859]: ---------------------------- MPD announces system playlist update May 28 23:16:45 volumio volumio[859]: info: Ignoring MPD Status Update May 28 23:16:45 volumio volumio[859]: info: ------------------------------ 3ms May 28 23:16:45 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:45 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play May 28 23:16:45 volumio volumio[859]: info: ------------------------------ 2ms May 28 23:16:45 volumio volumio[859]: info: sendMpdCommand play took 1 milliseconds May 28 23:16:46 volumio volumio[859]: info: May 28 23:16:46 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:46 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:46 volumio volumio[859]: info: May 28 23:16:46 volumio volumio[859]: ---------------------------- MPD announces state update: player May 28 23:16:46 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds May 28 23:16:46 volumio volumio[859]: info: ControllerMpd::getState May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:46 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds May 28 23:16:46 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::parseState May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:46 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:46 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:46 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:46 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CELLO MOON","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2626/128/stream","trackType":""} May 28 23:16:46 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop May 28 23:16:46 volumio volumio[859]: info: ------------------------------ 6ms May 28 23:16:46 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 23:16:46 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo May 28 23:16:46 volumio volumio[859]: info: ControllerMpd::pushState May 28 23:16:46 volumio volumio[859]: info: CoreCommandRouter::servicePushState May 28 23:16:46 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:46 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CELLO MOON","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2626/128/stream","trackType":""} May 28 23:16:46 volumio volumio[859]: verbose: CURRENT POSITION 0 May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::syncState stateService play May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play May 28 23:16:46 volumio volumio[859]: info: Received an update from plugin. extracting info from payload May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:16:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:46 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:16:46 volumio volumio[859]: info: ------------------------------ 10ms May 28 23:16:51 volumio volumio[859]: info: CoreCommandRouter::volumioGetState May 28 23:16:55 volumio volumio[859]: info: CoreCommandRouter::volumioSeek May 28 23:16:55 volumio volumio[859]: info: CoreStateMachine::seek May 28 23:16:55 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:55 volumio volumio[859]: info: TRACKBLOCK {"uri":"calmradio://56/766","service":"calmradio","trackType":"CalmRadio","radioType":"web","name":"CELLO MOON","title":"CELLO MOON","albumart":"https://arts.calmradio.com/fapi/000/000/000/000/000/766/c291171077ff04a41f2cf86aede36d17745f0fc36246c710c52d5bec1129.png","type":"webradio","samplerate":"","bitdepth":0,"channels":0} May 28 23:16:55 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer May 28 23:16:55 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:16:55 volumio volumio[859]: info: [1748467015042] ControllerCalmRadio::seek to 0 May 28 23:16:55 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 23:16:55 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:16:55 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:17:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 23:17:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 28 23:17:09 volumio volumio[859]: info: Starting Uninstall of plugin music_service - calmradio May 28 23:17:09 volumio volumio[859]: info: Uninstalling plugin calmradio May 28 23:17:09 volumio volumio[859]: info: CoreCommandRouter::volumioRemoveToBrowseSourcescalmradio May 28 23:17:09 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 23:17:09 volumio volumio[859]: Cannot find translation for source Randomizer May 28 23:17:09 volumio volumio[859]: Cannot find translation for source 80s80s Radio May 28 23:17:09 volumio volumio[859]: Cannot find translation for source Bandcamp Discover May 28 23:17:09 volumio volumio[859]: Cannot find translation for source Calm Radio May 28 23:17:09 volumio volumio[859]: info: Disabling plugin calmradio May 28 23:17:09 volumio volumio[859]: info: Checking if uninstall.sh is present May 28 23:17:09 volumio volumio[859]: info: Executing uninstall.sh May 28 23:17:09 volumio sudo[5921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/calmradio/uninstall.sh May 28 23:17:09 volumio sudo[5921]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 23:17:09 volumio sudo[5921]: pam_unix(sudo:session): session closed for user root May 28 23:17:09 volumio volumio[859]: info: Uninstall script completed May 28 23:17:09 volumio volumio[859]: info: Removing plugin calmradio from configuration May 28 23:17:09 volumio volumio[859]: info: Successfully removed calmradio configuration files May 28 23:17:09 volumio volumio[859]: info: Plugin folders cleanup May 28 23:17:09 volumio volumio[859]: info: Scanning into folder /volumio/app/plugins/ May 28 23:17:09 volumio volumio[859]: info: Scanning category audio_interface May 28 23:17:09 volumio volumio[859]: info: Scanning category miscellanea May 28 23:17:09 volumio volumio[859]: info: Scanning category music_service May 28 23:17:09 volumio volumio[859]: info: Scanning category plugins.json May 28 23:17:09 volumio volumio[859]: info: Scanning category system_controller May 28 23:17:09 volumio volumio[859]: info: Scanning category user_interface May 28 23:17:09 volumio volumio[859]: info: Scanning into folder /data/plugins/ May 28 23:17:09 volumio volumio[859]: info: Scanning category music_service May 28 23:17:09 volumio volumio[859]: info: Cleaning folder for calmradio May 28 23:17:09 volumio volumio[859]: info: Scanning category system_controller May 28 23:17:09 volumio volumio[859]: info: Scanning category user_interface May 28 23:17:09 volumio volumio[859]: info: Plugin folders cleanup completed May 28 23:17:09 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 23:17:09 volumio volumio[859]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.2.0","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Controradio","name":"controradio","category":"music_service","version":"1.0.0","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"DMD2 Music","name":"dmd2_music","category":"music_service","version":"1.1.3","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-meter-Basic","name":"peppymeterbasic","category":"user_interface","version":"0.0.3","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"3.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.5.1","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":false,"active":false}] May 28 23:17:09 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 28 23:17:16 volumio volumio[859]: info: Enabling plugin controradio May 28 23:17:16 volumio volumio[859]: info: Loading plugin "controradio"... May 28 23:17:16 volumio volumio[859]: error: !!!! WARNING !!!! May 28 23:17:16 volumio volumio[859]: error: The plugin music_service/controradio failed to load, setting it to stopped. Error: Error: Cannot find module 'fast-xml-parser' May 28 23:17:16 volumio volumio[859]: Require stack: May 28 23:17:16 volumio volumio[859]: - /data/plugins/music_service/controradio/index.js May 28 23:17:16 volumio volumio[859]: - /volumio/app/pluginmanager.js May 28 23:17:16 volumio volumio[859]: - /volumio/app/index.js May 28 23:17:16 volumio volumio[859]: - /volumio/index.js May 28 23:17:16 volumio volumio[859]: error: Stack trace: Error: Cannot find module 'fast-xml-parser' May 28 23:17:16 volumio volumio[859]: Require stack: May 28 23:17:16 volumio volumio[859]: - /data/plugins/music_service/controradio/index.js May 28 23:17:16 volumio volumio[859]: - /volumio/app/pluginmanager.js May 28 23:17:16 volumio volumio[859]: - /volumio/app/index.js May 28 23:17:16 volumio volumio[859]: - /volumio/index.js May 28 23:17:16 volumio volumio[859]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) May 28 23:17:16 volumio volumio[859]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) May 28 23:17:16 volumio volumio[859]: at Module.require (internal/modules/cjs/loader.js:952:19) May 28 23:17:16 volumio volumio[859]: at require (internal/modules/cjs/helpers.js:88:18) May 28 23:17:16 volumio volumio[859]: at Object. (/data/plugins/music_service/controradio/index.js:5:21) May 28 23:17:16 volumio volumio[859]: at Module._compile (internal/modules/cjs/loader.js:1063:30) May 28 23:17:16 volumio volumio[859]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) May 28 23:17:16 volumio volumio[859]: at Module.load (internal/modules/cjs/loader.js:928:32) May 28 23:17:16 volumio volumio[859]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) May 28 23:17:16 volumio volumio[859]: at Module.require (internal/modules/cjs/loader.js:952:19) May 28 23:17:16 volumio volumio[859]: at require (internal/modules/cjs/helpers.js:88:18) May 28 23:17:16 volumio volumio[859]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) May 28 23:17:16 volumio volumio[859]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 28 23:17:16 volumio volumio[859]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 28 23:17:16 volumio volumio[859]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 28 23:17:16 volumio volumio[859]: error: !!!! WARNING !!!! May 28 23:17:16 volumio volumio[859]: info: Done. May 28 23:17:25 volumio volumio[859]: info: CoreCommandRouter::volumioGetState May 28 23:17:27 volumio volumio[859]: info: CoreCommandRouter::volumioNext May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::next May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::stop May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock May 28 23:17:27 volumio volumio[859]: info: CorePlayQueue::getTrackBlock May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::pushState May 28 23:17:27 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:17:27 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 23:17:27 volumio volumio[859]: info: CoreCommandRouter::volumioPushState May 28 23:17:27 volumio volumio[859]: info: CoreStateMachine::serviceStop May 28 23:17:27 volumio volumio[859]: info: CorePlayQueue::getTrack 0 May 28 23:17:27 volumio volumio[859]: info: CoreCommandRouter::serviceStop May 28 23:17:27 volumio volumio[859]: error: WARNING: No stop method for service calmradio May 28 23:17:28 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 23:17:28 volumio volumio[859]: TypeError: Cannot read property 'then' of undefined May 28 23:17:28 volumio volumio[859]: at CoreStateMachine.next (/volumio/app/statemachine.js:1177:9) May 28 23:17:28 volumio volumio[859]: at CoreCommandRouter.volumioNext (/volumio/app/index.js:103:28) May 28 23:17:28 volumio volumio[859]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:274:26) May 28 23:17:28 volumio volumio[859]: at Socket.emit (events.js:315:20) May 28 23:17:28 volumio volumio[859]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 28 23:17:28 volumio volumio[859]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 28 23:17:28 volumio volumio[859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 23:17:28 volumio sudo[5968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 23:16 May 28 23:17:28 volumio sudo[5968]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"