-- Logs begin at Tue 2021-08-24 17:22:42 UTC, end at Sun 2026-04-12 14:40:21 UTC. --
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::ClearQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::stPlaybackTimer
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::serviceStop
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::serviceStop
Apr 12 14:39:07 volumio volumio[808]: info: ControllerMpd::stop
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::clearPlayQueue
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::addQueueItems
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::addQueueItems
Apr 12 14:39:07 volumio volumio[808]: info: Adding Item to queue: webrp/2
Apr 12 14:39:07 volumio volumio[808]: info: Exploding uri webrp/2 in service radio_paradise
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPlay
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::play index 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::play index undefined
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::startPlaybackTimer
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand stop took 107 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/24920.jpg","uri":"https://stream.radioparadise.com/flac","name":"Ten Years Gone (feat. Bruce Springsteen)","title":"Ten Years Gone (feat. Bruce Springsteen)","artist":"The Waterboys","album":"Life, Death And Dennis Hopper","streaming":true,"disableUiControls":true,"duration":206,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:39:07 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::syncState stateService stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info: No code
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info:
Apr 12 14:39:07 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:07 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand stop took 105 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 14:39:07 volumio volumio[808]: info:
Apr 12 14:39:07 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:07 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand status took 12 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand clear took 12 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 12 14:39:07 volumio volumio[808]: error: updateQueue error: null
Apr 12 14:39:07 volumio volumio[808]: info: ------------------------------ 3ms
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand consume 1 took 2 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:07 volumio volumio[808]: info: [1776004747783] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/rock-flac
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/rock-flac"
Apr 12 14:39:07 volumio volumio[808]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 14:39:07 volumio volumio[808]: info: ------------------------------ 17ms
Apr 12 14:39:07 volumio volumio[808]: info:
Apr 12 14:39:07 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:07 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand add "https://stream.radioparadise.com/rock-flac" took 1 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 14:39:07 volumio volumio[808]: info: ------------------------------ 4ms
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand play took 2 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: [1776004747790] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=2
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::ClearQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::clearPlayQueue
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::addQueueItems
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::addQueueItems
Apr 12 14:39:07 volumio volumio[808]: info: Adding Item to queue: webrp/1
Apr 12 14:39:07 volumio volumio[808]: info: Exploding uri webrp/1 in service radio_paradise
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:39:07 volumio volumio[808]: info: CoreCommandRouter::volumioPlay
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::play index 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::play index undefined
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: info: CoreStateMachine::startPlaybackTimer
Apr 12 14:39:07 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:39:07 volumio volumio[808]: info:
Apr 12 14:39:07 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand stop took 14 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 14:39:07 volumio volumio[808]: info:
Apr 12 14:39:07 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:07 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand status took 3 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand clear took 3 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 12 14:39:07 volumio volumio[808]: error: updateQueue error: null
Apr 12 14:39:07 volumio volumio[808]: info: ------------------------------ 4ms
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 12 14:39:07 volumio volumio[808]: info: sendMpdCommand consume 1 took 3 milliseconds
Apr 12 14:39:07 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:08 volumio volumio[808]: info: [1776004747991] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flac
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flac"
Apr 12 14:39:08 volumio volumio[808]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 14:39:08 volumio volumio[808]: info: ------------------------------ 9ms
Apr 12 14:39:08 volumio volumio[808]: info:
Apr 12 14:39:08 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:08 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flac" took 2 milliseconds
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 14:39:08 volumio volumio[808]: info: ------------------------------ 9ms
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand play took 7 milliseconds
Apr 12 14:39:08 volumio volumio[808]: info: [1776004748002] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1
Apr 12 14:39:08 volumio volumio[808]: info: [1776004748416] [RadioParadise] received new metadata: {"time":76,"artist":"The Breeders","title":"Cannonball","album":"Last Splash","year":"1993","cover":"https://img.radioparadise.com/covers/l/8633.jpg","cover_med":"https://img.radioparadise.com/covers/m/8633.jpg","cover_small":"https://img.radioparadise.com/covers/s/8633.jpg"}
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/8633.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Cannonball","title":"Cannonball","artist":"The Breeders","album":"Last Splash","streaming":true,"disableUiControls":true,"duration":81,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:39:08 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::syncState stateService play
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:08 volumio volumio[808]: info: [1776004748423] [RadioParadise] setting new timer with duration of 81000 seconds.
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::volumioGetQueue
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::getQueue
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getQueue
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 1
Apr 12 14:39:08 volumio volumio[808]: info:
Apr 12 14:39:08 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:08 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:08 volumio volumio[808]: info:
Apr 12 14:39:08 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:08 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:08 volumio volumio[808]: info:
Apr 12 14:39:08 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:08 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand status took 3 milliseconds
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:08 volumio volumio[808]: info: ------------------------------ 6ms
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand status took 4 milliseconds
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:08 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:39:08 volumio volumio[808]: info: ------------------------------ 11ms
Apr 12 14:39:08 volumio volumio[808]: info: [1776004748610] [RadioParadise] received new metadata: {"time":183,"artist":"Neil Young","title":"Cowgirl In The Sand (live acoustic)","album":"4 Way Street","year":"1970","cover":"https://img.radioparadise.com/covers/l/10228.jpg","cover_med":"https://img.radioparadise.com/covers/m/10228.jpg","cover_small":"https://img.radioparadise.com/covers/s/10228.jpg"}
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/10228.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Cowgirl In The Sand (live acoustic)","title":"Cowgirl In The Sand (live acoustic)","artist":"Neil Young","album":"4 Way Street","streaming":true,"disableUiControls":true,"duration":188,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:39:08 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::syncState stateService play
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus play
Apr 12 14:39:08 volumio volumio[808]: info: Received an update from plugin. extracting info from payload
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:08 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:08 volumio volumio[808]: info: [1776004748621] [RadioParadise] setting new timer with duration of 188000 seconds.
Apr 12 14:39:08 volumio volumio[808]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 12 14:39:08 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:08 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:39:08 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:39:08 volumio volumio[808]: info: ------------------------------ 23ms
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:08 volumio volumio[808]: info: CorePlayQueue::getTrack 1
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::ClearQueue
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:28 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::stPlaybackTimer
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::serviceStop
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::serviceStop
Apr 12 14:39:28 volumio volumio[808]: info: ControllerMpd::stop
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::clearPlayQueue
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::addQueueItems
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::addQueueItems
Apr 12 14:39:28 volumio volumio[808]: info: Adding Item to queue: webrp/2
Apr 12 14:39:28 volumio volumio[808]: info: Exploding uri webrp/2 in service radio_paradise
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPlay
Apr 12 14:39:28 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::play index 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:28 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::play index undefined
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::startPlaybackTimer
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand stop took 75 milliseconds
Apr 12 14:39:28 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand stop took 62 milliseconds
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/10228.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Cowgirl In The Sand (live acoustic)","title":"Cowgirl In The Sand (live acoustic)","artist":"Neil Young","album":"4 Way Street","streaming":true,"disableUiControls":true,"duration":188,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:39:28 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::syncState stateService stop
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:28 volumio volumio[808]: info: No code
Apr 12 14:39:28 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:28 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:28 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:28 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand status took 16 milliseconds
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand clear took 7 milliseconds
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 12 14:39:28 volumio volumio[808]: error: updateQueue error: null
Apr 12 14:39:28 volumio volumio[808]: info: ------------------------------ 15ms
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand playlistinfo took 14 milliseconds
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand consume 1 took 15 milliseconds
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:28 volumio volumio[808]: info: [1776004768396] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/rock-flac
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/rock-flac"
Apr 12 14:39:28 volumio volumio[808]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 14:39:28 volumio volumio[808]: info: ------------------------------ 33ms
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:28 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand add "https://stream.radioparadise.com/rock-flac" took 2 milliseconds
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 14:39:28 volumio volumio[808]: info: ------------------------------ 4ms
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand play took 3 milliseconds
Apr 12 14:39:28 volumio volumio[808]: info: [1776004768403] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=2
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:28 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:39:28 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:39:28 volumio volumio[808]: info:
Apr 12 14:39:28 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:39:28 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:39:28 volumio volumio[808]: info: sendMpdCommand status took 3 milliseconds
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:28 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:28 volumio volumio[808]: info: ------------------------------ 6ms
Apr 12 14:39:29 volumio volumio[808]: info: sendMpdCommand status took 4 milliseconds
Apr 12 14:39:29 volumio volumio[808]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 12 14:39:29 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:39:29 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:39:29 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:29 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:39:29 volumio volumio[808]: info: ------------------------------ 12ms
Apr 12 14:39:29 volumio volumio[808]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 12 14:39:29 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:39:29 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:39:29 volumio volumio[808]: info: ------------------------------ 10ms
Apr 12 14:39:29 volumio volumio[808]: info: [1776004769019] [RadioParadise] received new metadata: {"time":56,"artist":"The Breeders","title":"Cannonball","album":"Last Splash","year":"1993","cover":"https://img.radioparadise.com/covers/l/8633.jpg","cover_med":"https://img.radioparadise.com/covers/m/8633.jpg","cover_small":"https://img.radioparadise.com/covers/s/8633.jpg"}
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/8633.jpg","uri":"https://stream.radioparadise.com/rock-flac","name":"Cannonball","title":"Cannonball","artist":"The Breeders","album":"Last Splash","streaming":true,"disableUiControls":true,"duration":61,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:39:29 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:39:29 volumio volumio[808]: info: CoreStateMachine::syncState stateService play
Apr 12 14:39:29 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:39:29 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:39:29 volumio volumio[808]: info: [1776004769025] [RadioParadise] setting new timer with duration of 61000 seconds.
Apr 12 14:39:29 volumio volumio[808]: info: CoreCommandRouter::volumioGetQueue
Apr 12 14:39:29 volumio volumio[808]: info: CoreStateMachine::getQueue
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getQueue
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:39:29 volumio volumio[808]: info: CorePlayQueue::getTrack 1
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::ClearQueue
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:40:00 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::stPlaybackTimer
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::serviceStop
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::serviceStop
Apr 12 14:40:00 volumio volumio[808]: info: ControllerMpd::stop
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::clearPlayQueue
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::addQueueItems
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::addQueueItems
Apr 12 14:40:00 volumio volumio[808]: info: Adding Item to queue: webrp/3
Apr 12 14:40:00 volumio volumio[808]: info: Exploding uri webrp/3 in service radio_paradise
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPlay
Apr 12 14:40:00 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::play index 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:40:00 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::play index undefined
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::startPlaybackTimer
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:40:00 volumio volumio[808]: info:
Apr 12 14:40:00 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand stop took 111 milliseconds
Apr 12 14:40:00 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand stop took 97 milliseconds
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/8633.jpg","uri":"https://stream.radioparadise.com/rock-flac","name":"Cannonball","title":"Cannonball","artist":"The Breeders","album":"Last Splash","streaming":true,"disableUiControls":true,"duration":61,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:40:00 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::syncState stateService stop
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:00 volumio volumio[808]: info: No code
Apr 12 14:40:00 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:00 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:00 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand clear
Apr 12 14:40:00 volumio volumio[808]: info:
Apr 12 14:40:00 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:40:00 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand status took 16 milliseconds
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand clear took 7 milliseconds
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 12 14:40:00 volumio volumio[808]: error: updateQueue error: null
Apr 12 14:40:00 volumio volumio[808]: info: ------------------------------ 16ms
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand consume 1 took 14 milliseconds
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:40:00 volumio volumio[808]: info: [1776004800908] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/world-etc-flac
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/world-etc-flac"
Apr 12 14:40:00 volumio volumio[808]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 12 14:40:00 volumio volumio[808]: info: ------------------------------ 39ms
Apr 12 14:40:00 volumio volumio[808]: info:
Apr 12 14:40:00 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:40:00 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand add "https://stream.radioparadise.com/world-etc-flac" took 8 milliseconds
Apr 12 14:40:00 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand play
Apr 12 14:40:00 volumio volumio[808]: info: ------------------------------ 6ms
Apr 12 14:40:00 volumio volumio[808]: info: sendMpdCommand play took 2 milliseconds
Apr 12 14:40:00 volumio volumio[808]: info: [1776004800921] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=3
Apr 12 14:40:01 volumio volumio[808]: info:
Apr 12 14:40:01 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:40:01 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:40:01 volumio volumio[808]: info:
Apr 12 14:40:01 volumio volumio[808]: ---------------------------- MPD announces system playlist update
Apr 12 14:40:01 volumio volumio[808]: info: Ignoring MPD Status Update
Apr 12 14:40:01 volumio volumio[808]: info:
Apr 12 14:40:01 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:40:01 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:40:01 volumio volumio[808]: info: sendMpdCommand status took 3 milliseconds
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:40:01 volumio volumio[808]: info: ------------------------------ 22ms
Apr 12 14:40:01 volumio volumio[808]: info: sendMpdCommand status took 21 milliseconds
Apr 12 14:40:01 volumio volumio[808]: info: sendMpdCommand playlistinfo took 20 milliseconds
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:40:01 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:40:01 volumio volumio[808]: info: ------------------------------ 29ms
Apr 12 14:40:01 volumio volumio[808]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 12 14:40:01 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:40:01 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 12 14:40:01 volumio volumio[808]: info: ------------------------------ 28ms
Apr 12 14:40:01 volumio volumio[808]: info: [1776004801546] [RadioParadise] received new metadata: {"time":20,"artist":"Balimaya Project","title":"Anka Tulon","album":"When The Dust Settles","year":"2023","cover":"https://img.radioparadise.com/covers/l/23709.jpg","cover_med":"https://img.radioparadise.com/covers/m/23709.jpg","cover_small":"https://img.radioparadise.com/covers/s/23709.jpg"}
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/23709.jpg","uri":"https://stream.radioparadise.com/world-etc-flac","name":"Anka Tulon","title":"Anka Tulon","artist":"Balimaya Project","album":"When The Dust Settles","streaming":true,"disableUiControls":true,"duration":25,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:40:01 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:40:01 volumio volumio[808]: info: CoreStateMachine::syncState stateService play
Apr 12 14:40:01 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:40:01 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:01 volumio volumio[808]: info: [1776004801553] [RadioParadise] setting new timer with duration of 25000 seconds.
Apr 12 14:40:01 volumio volumio[808]: info: CoreCommandRouter::volumioGetQueue
Apr 12 14:40:01 volumio volumio[808]: info: CoreStateMachine::getQueue
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getQueue
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:01 volumio volumio[808]: info: CorePlayQueue::getTrack 1
Apr 12 14:40:08 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
Apr 12 14:40:16 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::ClearQueue
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::stop
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 12 14:40:19 volumio volumio[808]: UNSET VOLATILE
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::stPlaybackTimer
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::updateTrackBlock
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrackBlock
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::serviceStop
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::serviceStop
Apr 12 14:40:19 volumio volumio[808]: info: ControllerMpd::stop
Apr 12 14:40:19 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand stop
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::clearPlayQueue
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::saveQueue
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushQueue
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::addQueueItems
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::addQueueItems
Apr 12 14:40:19 volumio volumio[808]: info: Adding Item to queue: webkbs/0
Apr 12 14:40:19 volumio volumio[808]: info: Exploding uri webkbs/0 in service personal_radio
Apr 12 14:40:19 volumio volumio[808]: info: sendMpdCommand stop took 28 milliseconds
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/23709.jpg","uri":"https://stream.radioparadise.com/world-etc-flac","name":"Anka Tulon","title":"Anka Tulon","artist":"Balimaya Project","album":"When The Dust Settles","streaming":true,"disableUiControls":true,"duration":25,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Apr 12 14:40:19 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::syncState stateService stop
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: No code
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info:
Apr 12 14:40:19 volumio volumio[808]: ---------------------------- MPD announces state update: player
Apr 12 14:40:19 volumio volumio[808]: info: ControllerMpd::getState
Apr 12 14:40:19 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand status
Apr 12 14:40:19 volumio volumio[808]: info: sendMpdCommand status took 6 milliseconds
Apr 12 14:40:19 volumio volumio[808]: verbose: ControllerMpd::parseState
Apr 12 14:40:19 volumio volumio[808]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 12 14:40:19 volumio volumio[808]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 12 14:40:19 volumio volumio[808]: verbose: ControllerMpd::parseTrackInfo
Apr 12 14:40:19 volumio volumio[808]: info: ControllerMpd::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::servicePushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""}
Apr 12 14:40:19 volumio volumio[808]: verbose: CURRENT POSITION 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::syncState stateService stop
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::syncState currentStatus stop
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: No code
Apr 12 14:40:19 volumio volumio[808]: info: CoreStateMachine::pushState
Apr 12 14:40:19 volumio volumio[808]: info: CorePlayQueue::getTrack 0
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::volumioPushState
Apr 12 14:40:19 volumio volumio[808]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 12 14:40:19 volumio volumio[808]: info: ------------------------------ 23ms
Apr 12 14:40:20 volumio volumio[808]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 12 14:40:20 volumio volumio[808]: ReferenceError: self is not defined
Apr 12 14:40:20 volumio volumio[808]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22)
Apr 12 14:40:20 volumio volumio[808]: at /data/plugins/music_service/personal_radio/index.js:487:12
Apr 12 14:40:20 volumio volumio[808]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15)
Apr 12 14:40:20 volumio volumio[808]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22)
Apr 12 14:40:20 volumio volumio[808]: at emitOne (events.js:116:13)
Apr 12 14:40:20 volumio volumio[808]: at Request.emit (events.js:211:7)
Apr 12 14:40:20 volumio volumio[808]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8)
Apr 12 14:40:20 volumio volumio[808]: at emitOne (events.js:116:13)
Apr 12 14:40:20 volumio volumio[808]: at ClientRequest.emit (events.js:211:7)
Apr 12 14:40:20 volumio volumio[808]: at Socket.socketErrorListener (_http_client.js:387:9)
Apr 12 14:40:20 volumio volumio[808]: at emitOne (events.js:116:13)
Apr 12 14:40:20 volumio volumio[808]: at Socket.emit (events.js:211:7)
Apr 12 14:40:20 volumio volumio[808]: at emitErrorNT (internal/streams/destroy.js:64:8)
Apr 12 14:40:20 volumio volumio[808]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Apr 12 14:40:20 volumio volumio[808]: at process._tickCallback (internal/process/next_tick.js:180:9)
Apr 12 14:40:20 volumio volumio[808]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 12 14:40:21 volumio sudo[2292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-12 14:39
Apr 12 14:40:21 volumio sudo[2292]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="cd11dc738d0d82822d0aa776d0729686b82e3758"
VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6"
VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021"
VOLUMIO_VERSION="2.907"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"