-- 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"