-- Logs begin at Fri 2026-02-27 14:48:26 KST, end at Fri 2026-02-27 15:30:39 KST. --
Feb 27 15:29:05 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:29:05 volumio volumio[577]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::ClearQueue
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::stPlaybackTimer
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::getTrack 52
Feb 27 15:29:05 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:05 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::serviceStop
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::getTrack 52
Feb 27 15:29:05 volumio volumio[577]: info: CoreCommandRouter::serviceStop
Feb 27 15:29:05 volumio volumio[577]: info: ControllerMpd::stop
Feb 27 15:29:05 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::clearPlayQueue
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:29:05 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:29:05 volumio volumio[577]: info: CoreStateMachine::addQueueItems
Feb 27 15:29:05 volumio volumio[577]: info: CorePlayQueue::addQueueItems
Feb 27 15:29:05 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:29:05 volumio volumio[577]: info: Adding Item to queue: calmradio://56/19
Feb 27 15:29:05 volumio volumio[577]: info: Exploding uri calmradio://56/19 in service calmradio
Feb 27 15:29:05 volumio volumio[577]: info: Calm Radio explodeUri for Cat 56 Chan 19
Feb 27 15:29:06 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:29:06 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:06 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:06 volumio volumio[577]: info: CoreCommandRouter::volumioPlay
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::play index 0
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::play index undefined
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:06 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::startPlaybackTimer
Feb 27 15:29:06 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:06 volumio volumio[577]: info: [1772173746290] ControllerCalmRadio::clearAddPlayTrack
Feb 27 15:29:06 volumio volumio[577]: {
Feb 27 15:29:06 volumio volumio[577]: uri: 'calmradio://56/19',
Feb 27 15:29:06 volumio volumio[577]: service: 'calmradio',
Feb 27 15:29:06 volumio volumio[577]: trackType: 'CalmRadio',
Feb 27 15:29:06 volumio volumio[577]: radioType: 'web',
Feb 27 15:29:06 volumio volumio[577]: name: 'SLEEP',
Feb 27 15:29:06 volumio volumio[577]: title: 'SLEEP',
Feb 27 15:29:06 volumio volumio[577]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/019/cfa06aedcb5d4ddebccce8c7a3dba9eb69baa74992d5ef2c6a072be6011e.png',
Feb 27 15:29:06 volumio volumio[577]: type: 'webradio',
Feb 27 15:29:06 volumio volumio[577]: samplerate: '',
Feb 27 15:29:06 volumio volumio[577]: bitdepth: 0,
Feb 27 15:29:06 volumio volumio[577]: channels: 0
Feb 27 15:29:06 volumio volumio[577]: }
Feb 27 15:29:06 volumio volumio[577]: info: Calm Radio getStreamUrl for Cat 56 Chan 19
Feb 27 15:29:06 volumio volumio[577]: STREAMURL: https://streams.calmradio.com/api/39/128/stream
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:06 volumio volumio[577]: info:
Feb 27 15:29:06 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand stop took 1106 milliseconds
Feb 27 15:29:06 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand stop took 35 milliseconds
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand clear
Feb 27 15:29:06 volumio volumio[577]: info:
Feb 27 15:29:06 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:06 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand status took 25 milliseconds
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand clear took 22 milliseconds
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/39/128/stream"
Feb 27 15:29:06 volumio volumio[577]: error: updateQueue error: null
Feb 27 15:29:06 volumio volumio[577]: info:
Feb 27 15:29:06 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:06 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:06 volumio volumio[577]: info: ------------------------------ 31ms
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand addid "https://streams.calmradio.com/api/39/128/stream" took 28 milliseconds
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:06 volumio volumio[577]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 27 15:29:06 volumio volumio[577]: verbose: MPD COMMAND [object Object]
Feb 27 15:29:06 volumio volumio[577]: info: ------------------------------ 81ms
Feb 27 15:29:06 volumio volumio[577]: info:
Feb 27 15:29:06 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:06 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:06 volumio volumio[577]: info: ------------------------------ 38ms
Feb 27 15:29:06 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 15:29:06 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 15:29:06 volumio volumio[577]: info: ------------------------------ 18ms
Feb 27 15:29:06 volumio volumio[577]: info: sendMpdCommand play took 14 milliseconds
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand status took 4 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand status took 21 milliseconds
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: 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":"SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:08 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus stop
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 44ms
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: 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":"SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:08 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:08 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 61ms
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:08 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:08 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 12ms
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand status took 8 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 13ms
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand status took 11 milliseconds
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"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 - Softest Sleep Ever - My Best Sleep Ever","artist":"CALMRADIO.COM - Sleep Channel","album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:08 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:08 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 46ms
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand playlistinfo took 24 milliseconds
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"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 - Softest Sleep Ever - My Best Sleep Ever","artist":"CALMRADIO.COM - Sleep Channel","album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:08 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:08 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: ------------------------------ 60ms
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioNext
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::next
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::stPlaybackTimer
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::serviceStop
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreCommandRouter::serviceStop
Feb 27 15:29:08 volumio volumio[577]: info: [1772173748637] ControllerCalmRadio::stop
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:08 volumio volumio[577]: info:
Feb 27 15:29:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:08 volumio volumio[577]: info: sendMpdCommand stop took 50 milliseconds
Feb 27 15:29:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::play index undefined
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: info: CoreStateMachine::startPlaybackTimer
Feb 27 15:29:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:08 volumio volumio[577]: info: [1772173748698] ControllerCalmRadio::clearAddPlayTrack
Feb 27 15:29:08 volumio volumio[577]: {
Feb 27 15:29:08 volumio volumio[577]: uri: 'calmradio://56/19',
Feb 27 15:29:08 volumio volumio[577]: service: 'calmradio',
Feb 27 15:29:08 volumio volumio[577]: trackType: 'CalmRadio',
Feb 27 15:29:08 volumio volumio[577]: radioType: 'web',
Feb 27 15:29:08 volumio volumio[577]: name: 'SLEEP',
Feb 27 15:29:08 volumio volumio[577]: title: 'SLEEP',
Feb 27 15:29:08 volumio volumio[577]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/019/cfa06aedcb5d4ddebccce8c7a3dba9eb69baa74992d5ef2c6a072be6011e.png',
Feb 27 15:29:08 volumio volumio[577]: type: 'webradio',
Feb 27 15:29:08 volumio volumio[577]: samplerate: '',
Feb 27 15:29:08 volumio volumio[577]: bitdepth: 0,
Feb 27 15:29:08 volumio volumio[577]: channels: 0
Feb 27 15:29:08 volumio volumio[577]: }
Feb 27 15:29:08 volumio volumio[577]: info: Calm Radio getStreamUrl for Cat 56 Chan 19
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:09 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:09 volumio volumio[577]: STREAMURL: https://streams.calmradio.com/api/39/128/stream
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand status took 467 milliseconds
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand stop took 3 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand clear
Feb 27 15:29:09 volumio volumio[577]: info:
Feb 27 15:29:09 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:09 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand playlistinfo took 23 milliseconds
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand clear took 24 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/39/128/stream"
Feb 27 15:29:09 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:09 volumio volumio[577]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current calmradio Received mpd
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 524ms
Feb 27 15:29:09 volumio volumio[577]: error: updateQueue error: null
Feb 27 15:29:09 volumio volumio[577]: info:
Feb 27 15:29:09 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:09 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 36ms
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand addid "https://streams.calmradio.com/api/39/128/stream" took 33 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: MPD COMMAND [object Object]
Feb 27 15:29:09 volumio volumio[577]: info:
Feb 27 15:29:09 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:09 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 14ms
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 12ms
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand play took 8 milliseconds
Feb 27 15:29:09 volumio volumio[577]: info:
Feb 27 15:29:09 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:09 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:09 volumio volumio[577]: info:
Feb 27 15:29:09 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:09 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand status took 6 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand status took 7 milliseconds
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:09 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:09 volumio volumio[577]: 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":"SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:09 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus stop
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 32ms
Feb 27 15:29:09 volumio volumio[577]: info: sendMpdCommand playlistinfo took 9 milliseconds
Feb 27 15:29:09 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:09 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:09 volumio volumio[577]: 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":"SLEEP","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:09 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:09 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:09 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:09 volumio volumio[577]: info: ------------------------------ 51ms
Feb 27 15:29:10 volumio volumio[577]: info:
Feb 27 15:29:10 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:10 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:10 volumio volumio[577]: info:
Feb 27 15:29:10 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:10 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:10 volumio volumio[577]: info:
Feb 27 15:29:10 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:10 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:10 volumio volumio[577]: info:
Feb 27 15:29:10 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:10 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:10 volumio volumio[577]: info: ------------------------------ 23ms
Feb 27 15:29:10 volumio volumio[577]: info: sendMpdCommand status took 20 milliseconds
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:10 volumio volumio[577]: info: ------------------------------ 9ms
Feb 27 15:29:10 volumio volumio[577]: info: sendMpdCommand status took 13 milliseconds
Feb 27 15:29:10 volumio volumio[577]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:10 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:10 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:10 volumio volumio[577]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"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 - Softest Sleep Ever - My Best Sleep Ever","artist":"CALMRADIO.COM - Sleep Channel","album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:10 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:10 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:10 volumio volumio[577]: info: ------------------------------ 59ms
Feb 27 15:29:10 volumio volumio[577]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 27 15:29:10 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:10 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:10 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:10 volumio volumio[577]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"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 - Softest Sleep Ever - My Best Sleep Ever","artist":"CALMRADIO.COM - Sleep Channel","album":null,"uri":"https://streams.calmradio.com/api/39/128/stream","trackType":""}
Feb 27 15:29:10 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:10 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:10 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:10 volumio volumio[577]: info: ------------------------------ 66ms
Feb 27 15:29:29 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:29:29 volumio volumio[577]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::ClearQueue
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::stPlaybackTimer
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:29 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:29 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::serviceStop
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:29 volumio volumio[577]: info: CoreCommandRouter::serviceStop
Feb 27 15:29:29 volumio volumio[577]: info: [1772173769747] ControllerCalmRadio::stop
Feb 27 15:29:29 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::clearPlayQueue
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:29:29 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:29:29 volumio volumio[577]: info: CoreStateMachine::addQueueItems
Feb 27 15:29:29 volumio volumio[577]: info: CorePlayQueue::addQueueItems
Feb 27 15:29:29 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:29:29 volumio volumio[577]: info: Adding Item to queue: calmradio://56/702
Feb 27 15:29:29 volumio volumio[577]: info: Exploding uri calmradio://56/702 in service calmradio
Feb 27 15:29:29 volumio volumio[577]: info: Calm Radio explodeUri for Cat 56 Chan 702
Feb 27 15:29:30 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:29:30 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:29:30 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:29:30 volumio volumio[577]: info: CoreCommandRouter::volumioPlay
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::play index 0
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::play index undefined
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:29:30 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:30 volumio volumio[577]: info: CoreStateMachine::startPlaybackTimer
Feb 27 15:29:30 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:30 volumio volumio[577]: info: [1772173770325] ControllerCalmRadio::clearAddPlayTrack
Feb 27 15:29:30 volumio volumio[577]: {
Feb 27 15:29:30 volumio volumio[577]: uri: 'calmradio://56/702',
Feb 27 15:29:30 volumio volumio[577]: service: 'calmradio',
Feb 27 15:29:30 volumio volumio[577]: trackType: 'CalmRadio',
Feb 27 15:29:30 volumio volumio[577]: radioType: 'web',
Feb 27 15:29:30 volumio volumio[577]: name: 'LONELY CELLO',
Feb 27 15:29:30 volumio volumio[577]: title: 'LONELY CELLO',
Feb 27 15:29:30 volumio volumio[577]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/702/48cb1c41b29ce1544a07b7930dd96ecc4516a9a46357c932e1a4e1f615e8.png',
Feb 27 15:29:30 volumio volumio[577]: type: 'webradio',
Feb 27 15:29:30 volumio volumio[577]: samplerate: '',
Feb 27 15:29:30 volumio volumio[577]: bitdepth: 0,
Feb 27 15:29:30 volumio volumio[577]: channels: 0
Feb 27 15:29:30 volumio volumio[577]: }
Feb 27 15:29:30 volumio volumio[577]: info: Calm Radio getStreamUrl for Cat 56 Chan 702
Feb 27 15:29:30 volumio volumio[577]: STREAMURL: https://streams.calmradio.com/api/2492/128/stream
Feb 27 15:29:30 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:29:30 volumio volumio[577]: info:
Feb 27 15:29:30 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:30 volumio volumio[577]: info: sendMpdCommand stop took 1249 milliseconds
Feb 27 15:29:30 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:30 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand stop took 48 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand clear
Feb 27 15:29:31 volumio volumio[577]: info:
Feb 27 15:29:31 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:31 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand status took 30 milliseconds
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand clear took 28 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2492/128/stream"
Feb 27 15:29:31 volumio volumio[577]: error: updateQueue error: null
Feb 27 15:29:31 volumio volumio[577]: info:
Feb 27 15:29:31 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:31 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 29ms
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand playlistinfo took 23 milliseconds
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2492/128/stream" took 23 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:31 volumio volumio[577]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 27 15:29:31 volumio volumio[577]: verbose: MPD COMMAND [object Object]
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 69ms
Feb 27 15:29:31 volumio volumio[577]: info:
Feb 27 15:29:31 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:29:31 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 22ms
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 7ms
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand play took 5 milliseconds
Feb 27 15:29:31 volumio volumio[577]: info:
Feb 27 15:29:31 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:31 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:31 volumio volumio[577]: info:
Feb 27 15:29:31 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:29:31 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand status took 7 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand status took 21 milliseconds
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand playlistinfo took 17 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:31 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:31 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:31 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:31 volumio volumio[577]: 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":"LONELY CELLO","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2492/128/stream","trackType":""}
Feb 27 15:29:31 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus stop
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 47ms
Feb 27 15:29:31 volumio volumio[577]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 27 15:29:31 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:29:31 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:29:31 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:29:31 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:29:31 volumio volumio[577]: 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":"LONELY CELLO","artist":null,"album":null,"uri":"https://streams.calmradio.com/api/2492/128/stream","trackType":""}
Feb 27 15:29:31 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:29:31 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:31 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:29:31 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:31 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:29:31 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:29:31 volumio volumio[577]: info: ------------------------------ 73ms
Feb 27 15:30:07 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:30:07 volumio volumio[577]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::ClearQueue
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::stPlaybackTimer
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:07 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:30:07 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::serviceStop
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:07 volumio volumio[577]: info: CoreCommandRouter::serviceStop
Feb 27 15:30:07 volumio volumio[577]: info: [1772173807800] ControllerCalmRadio::stop
Feb 27 15:30:07 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::clearPlayQueue
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:30:07 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:30:07 volumio volumio[577]: info: CoreStateMachine::addQueueItems
Feb 27 15:30:07 volumio volumio[577]: info: CorePlayQueue::addQueueItems
Feb 27 15:30:07 volumio volumio[577]: info: Preload queue cleared
Feb 27 15:30:07 volumio volumio[577]: info: Adding Item to queue: calmradio://56/766
Feb 27 15:30:07 volumio volumio[577]: info: Exploding uri calmradio://56/766 in service calmradio
Feb 27 15:30:07 volumio volumio[577]: info: Calm Radio explodeUri for Cat 56 Chan 766
Feb 27 15:30:08 volumio volumio[577]: info: CoreCommandRouter::volumioPushQueue
Feb 27 15:30:08 volumio volumio[577]: info: CorePlayQueue::saveQueue
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::updateTrackBlock
Feb 27 15:30:08 volumio volumio[577]: info: CorePlayQueue::getTrackBlock
Feb 27 15:30:08 volumio volumio[577]: info: CoreCommandRouter::volumioPlay
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::play index 0
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::stop
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::play index undefined
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 15:30:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:08 volumio volumio[577]: info: CoreStateMachine::startPlaybackTimer
Feb 27 15:30:08 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:08 volumio volumio[577]: info: [1772173808343] ControllerCalmRadio::clearAddPlayTrack
Feb 27 15:30:08 volumio volumio[577]: {
Feb 27 15:30:08 volumio volumio[577]: uri: 'calmradio://56/766',
Feb 27 15:30:08 volumio volumio[577]: service: 'calmradio',
Feb 27 15:30:08 volumio volumio[577]: trackType: 'CalmRadio',
Feb 27 15:30:08 volumio volumio[577]: radioType: 'web',
Feb 27 15:30:08 volumio volumio[577]: name: 'CELLO MOON',
Feb 27 15:30:08 volumio volumio[577]: title: 'CELLO MOON',
Feb 27 15:30:08 volumio volumio[577]: albumart: 'https://arts.calmradio.com/fapi/000/000/000/000/000/766/c291171077ff04a41f2cf86aede36d17745f0fc36246c710c52d5bec1129.png',
Feb 27 15:30:08 volumio volumio[577]: type: 'webradio',
Feb 27 15:30:08 volumio volumio[577]: samplerate: '',
Feb 27 15:30:08 volumio volumio[577]: bitdepth: 0,
Feb 27 15:30:08 volumio volumio[577]: channels: 0
Feb 27 15:30:08 volumio volumio[577]: }
Feb 27 15:30:08 volumio volumio[577]: info: Calm Radio getStreamUrl for Cat 56 Chan 766
Feb 27 15:30:08 volumio volumio[577]: STREAMURL: https://streams.calmradio.com/api/2626/128/stream
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 15:30:08 volumio volumio[577]: info:
Feb 27 15:30:08 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand stop took 1105 milliseconds
Feb 27 15:30:08 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand stop took 128 milliseconds
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand clear
Feb 27 15:30:08 volumio volumio[577]: info:
Feb 27 15:30:08 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:30:08 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand status took 40 milliseconds
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand clear took 38 milliseconds
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand addid "https://streams.calmradio.com/api/2626/128/stream"
Feb 27 15:30:08 volumio volumio[577]: error: updateQueue error: null
Feb 27 15:30:08 volumio volumio[577]: info:
Feb 27 15:30:08 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:30:08 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:30:08 volumio volumio[577]: info: ------------------------------ 41ms
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand playlistinfo took 32 milliseconds
Feb 27 15:30:08 volumio volumio[577]: info: sendMpdCommand addid "https://streams.calmradio.com/api/2626/128/stream" took 31 milliseconds
Feb 27 15:30:08 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:30:08 volumio volumio[577]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 27 15:30:08 volumio volumio[577]: verbose: MPD COMMAND [object Object]
Feb 27 15:30:09 volumio volumio[577]: info: ------------------------------ 117ms
Feb 27 15:30:09 volumio volumio[577]: info:
Feb 27 15:30:09 volumio volumio[577]: ---------------------------- MPD announces system playlist update
Feb 27 15:30:09 volumio volumio[577]: info: Ignoring MPD Status Update
Feb 27 15:30:09 volumio volumio[577]: info: ------------------------------ 42ms
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 15:30:09 volumio volumio[577]: info: ------------------------------ 18ms
Feb 27 15:30:09 volumio volumio[577]: info: sendMpdCommand play took 12 milliseconds
Feb 27 15:30:09 volumio volumio[577]: info:
Feb 27 15:30:09 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:30:09 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:30:09 volumio volumio[577]: info:
Feb 27 15:30:09 volumio volumio[577]: ---------------------------- MPD announces state update: player
Feb 27 15:30:09 volumio volumio[577]: info: ControllerMpd::getState
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 15:30:09 volumio volumio[577]: info: sendMpdCommand status took 5 milliseconds
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:30:09 volumio volumio[577]: info: sendMpdCommand status took 6 milliseconds
Feb 27 15:30:09 volumio volumio[577]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::parseState
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:30:09 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:30:09 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:30:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:09 volumio volumio[577]: 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":""}
Feb 27 15:30:09 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus stop
Feb 27 15:30:09 volumio volumio[577]: info: ------------------------------ 20ms
Feb 27 15:30:09 volumio volumio[577]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 27 15:30:09 volumio volumio[577]: verbose: ControllerMpd::parseTrackInfo
Feb 27 15:30:09 volumio volumio[577]: info: ControllerMpd::pushState
Feb 27 15:30:09 volumio volumio[577]: info: CoreCommandRouter::servicePushState
Feb 27 15:30:09 volumio volumio[577]: info: CorePlayQueue::getTrack 0
Feb 27 15:30:09 volumio volumio[577]: 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":""}
Feb 27 15:30:09 volumio volumio[577]: verbose: CURRENT POSITION 0
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::syncState stateService play
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::syncState currentStatus play
Feb 27 15:30:09 volumio volumio[577]: info: Received an update from plugin. extracting info from payload
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:30:09 volumio volumio[577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 15:30:09 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:30:09 volumio volumio[577]: info: CoreStateMachine::pushState
Feb 27 15:30:09 volumio volumio[577]: info: CoreCommandRouter::volumioPushState
Feb 27 15:30:09 volumio volumio[577]: info: ------------------------------ 37ms
Feb 27 15:30:37 volumio volumio[577]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 27 15:30:37 volumio volumio[577]: TypeError: Cannot read property 'slice' of null
Feb 27 15:30:37 volumio volumio[577]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41)
Feb 27 15:30:37 volumio volumio[577]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7)
Feb 27 15:30:37 volumio volumio[577]: at Object.onceWrapper (events.js:422:26)
Feb 27 15:30:37 volumio volumio[577]: at ClientRequest.emit (events.js:315:20)
Feb 27 15:30:37 volumio volumio[577]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27)
Feb 27 15:30:37 volumio volumio[577]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17)
Feb 27 15:30:37 volumio volumio[577]: at TLSSocket.socketOnData (_http_client.js:509:22)
Feb 27 15:30:37 volumio volumio[577]: at TLSSocket.emit (events.js:315:20)
Feb 27 15:30:37 volumio volumio[577]: at addChunk (internal/streams/readable.js:309:12)
Feb 27 15:30:37 volumio volumio[577]: at readableAddChunk (internal/streams/readable.js:284:9)
Feb 27 15:30:37 volumio volumio[577]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10)
Feb 27 15:30:37 volumio volumio[577]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23)
Feb 27 15:30:37 volumio volumio[577]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 27 15:30:39 volumio sudo[7760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-27 15:29
Feb 27 15:30:39 volumio sudo[7760]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"