Jan 25 16:42:02 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: randomizer , handleBrowseUri Jan 25 16:42:02 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:42:12 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , handleBrowseUri Jan 25 16:42:12 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioAddQueueItems Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::addQueueItems Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::addQueueItems Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Adding Item to queue: webrp/1 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Using cached record of: webrp/1 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushQueue Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::saveQueue Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::updateTrackBlock Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrackBlock Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPlay Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::play index 192 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::stop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::updateTrackBlock Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrackBlock Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::stPlaybackTimer Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::serviceStop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::serviceStop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ControllerMpd::stop Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand stop took 9 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/7712.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"Flowers In December","title":"Flowers In December","artist":"Mazzy Star","album":"Among My Swan","streaming":true,"disableUiControls":true,"duration":273,"seek":229,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: CURRENT POSITION 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState stateService stop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState currentStatus stop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: No code Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::play index undefined Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::startPlaybackTimer Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: [RadioParadise] Matched station: Radio Paradise Mellow Mix (FLAC), chan=1 Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand status took 7 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand stop took 2 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand clear took 3 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:14 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:14 volumiopc13 volumio[1216]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 25 16:42:14 volumiopc13 volumio[1216]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 13ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 7ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 6ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:14 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:14 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand consume 1 took 3 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 0ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: [1769355734826] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flacm Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" took 2 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand play Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Jan 25 16:42:14 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: sendMpdCommand play took 1 milliseconds Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:14 volumiopc13 volumio[1216]: info: [RadioParadise] Using metadata URL: https://api.radioparadise.com/api/now_playing?chan=1 Jan 25 16:42:14 volumiopc13 volumio[1216]: info: [1769355734830] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 5ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Jan 25 16:42:15 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 2 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:15 volumiopc13 volumio[1216]: info: [1769355735379] [RadioParadise] received new metadata: {"time":246,"artist":"Mazzy Star","title":"Flowers In December","album":"Among My Swan","year":"1996","cover":"https://img.radioparadise.com/covers/l/7712.jpg","cover_med":"https://img.radioparadise.com/covers/m/7712.jpg","cover_small":"https://img.radioparadise.com/covers/s/7712.jpg"} Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/7712.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"Flowers In December","title":"Flowers In December","artist":"Mazzy Star","album":"Among My Swan","streaming":true,"disableUiControls":true,"duration":251,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 25 16:42:15 volumiopc13 volumio[1216]: verbose: CURRENT POSITION 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState stateService play Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState currentStatus stop Jan 25 16:42:15 volumiopc13 volumio[1216]: info: [1769355735380] [RadioParadise] setting new timer with duration of 251000 seconds. Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:15 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 193 Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Jan 25 16:42:17 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand status took 2 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand status took 2 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:17 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:17 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:17 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:17 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:20 volumiopc13 volumio[1216]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 16:42:20 volumiopc13 volumio[1216]: info: CoreCommandRouter::Close All Modals sent Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPlay Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::play index 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::stop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::stPlaybackTimer Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::updateTrackBlock Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrackBlock Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::serviceStop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::serviceStop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::stop Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand stop took 5 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/7712.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"Flowers In December","title":"Flowers In December","artist":"Mazzy Star","album":"Among My Swan","streaming":true,"disableUiControls":true,"duration":251,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: CURRENT POSITION 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState stateService stop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState currentStatus stop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: No code Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 192 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::play index undefined Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::startPlaybackTimer Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: [RadioParadise] Matched station: Radio Paradise Mellow Mix (FLAC), chan=1 Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 8 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand stop took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand clear took 3 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 3 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 3 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreStateMachine::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::volumioPushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 20ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 12ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 12ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:30 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:30 volumiopc13 volumio[1216]: error: updateQueue error: null Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 13ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand consume 1 took 11 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: [1769355750666] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flacm Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flacm" took 2 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand play Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 4ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand play took 3 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: [RadioParadise] Using metadata URL: https://api.radioparadise.com/api/now_playing?chan=1 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: [1769355750673] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 6ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 7ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 3ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Jan 25 16:42:30 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand status took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:30 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:30 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:30 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:30 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:30 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:31 volumiopc13 volumio[1216]: info: [1769355751220] [RadioParadise] received new metadata: {"time":229,"artist":"Mazzy Star","title":"Flowers In December","album":"Among My Swan","year":"1996","cover":"https://img.radioparadise.com/covers/l/7712.jpg","cover_med":"https://img.radioparadise.com/covers/m/7712.jpg","cover_small":"https://img.radioparadise.com/covers/s/7712.jpg"} Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:31 volumiopc13 volumio[1216]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/7712.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"Flowers In December","title":"Flowers In December","artist":"Mazzy Star","album":"Among My Swan","streaming":true,"disableUiControls":true,"duration":234,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 25 16:42:31 volumiopc13 volumio[1216]: verbose: CURRENT POSITION 0 Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState stateService play Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CoreStateMachine::syncState currentStatus stop Jan 25 16:42:31 volumiopc13 volumio[1216]: info: [1769355751221] [RadioParadise] setting new timer with duration of 234000 seconds. Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:31 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 1 Jan 25 16:42:31 volumiopc13 volumio[1216]: info: Prefetching next song Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces system playlist update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Ignoring MPD Status Update Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Jan 25 16:42:32 volumiopc13 volumio[1216]: ---------------------------- MPD announces state update: player Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::getState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand status Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand status took 0 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 0ms Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 1ms Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand status took 1 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseState Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:32 volumiopc13 volumio[1216]: verbose: ControllerMpd::parseTrackInfo Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ControllerMpd::pushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CoreCommandRouter::servicePushState Jan 25 16:42:32 volumiopc13 volumio[1216]: info: CorePlayQueue::getTrack 0 Jan 25 16:42:32 volumiopc13 volumio[1216]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:32 volumiopc13 volumio[1216]: info: ------------------------------ 2ms Jan 25 16:42:36 volumiopc13 volumio[1216]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 16:42:36 volumiopc13 volumio[1216]: info: CoreCommandRouter::Close All Modals sent Jan 25 16:42:59 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 16:42:59 volumiopc13 volumio[1216]: info: CURURI: playlists Jan 25 16:42:59 volumiopc13 volumio[1216]: info: Listing playlists Jan 25 16:42:59 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:43:03 volumiopc13 volumio[1216]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 16:43:03 volumiopc13 volumio[1216]: info: CURURI: playlists/HiRes Webradio Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preload queue cleared Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://stream.radioparadise.com/flacm Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: http://stream.radioparadise.com/global-flacm Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: http://stream.radioparadise.com/beyond-flacm Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://mediacp.jb-radio.net:8001/flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://radio3.radio-calico.com:8443/calico Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://frequence3.net-radio.fr/frequence3.flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://frequence3.net-radio.fr/frequence3gold.flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://mscp3.live-streams.nl:8362/flac.flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://mscp3.live-streams.nl:8252/class-flac.flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://mscp3.live-streams.nl:8342/jazz-flac.flac Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://motherearth.streamserver24.com/listen/motherearth/motherearth Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Preloading song: https://motherearth.streamserver24.com/listen/motherearth_instrumental/motherearth.instrumental Jan 25 16:43:03 volumiopc13 volumio[1216]: info: Exploding uri https://stream.radioparadise.com/mellow-flacm in service radio_paradise Jan 25 16:43:03 volumiopc13 volumio[1216]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/mellow-flacm" Jan 25 16:43:03 volumiopc13 volumio[1216]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 16:43:03 volumiopc13 volumio[1216]: TypeError: Cannot read properties of undefined (reading 'then') Jan 25 16:43:03 volumiopc13 volumio[1216]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Jan 25 16:43:03 volumiopc13 volumio[1216]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jan 25 16:43:03 volumiopc13 volumio[1216]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jan 25 16:43:03 volumiopc13 volumio[1216]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Jan 25 16:43:03 volumiopc13 volumio[1216]: at listOnTimeout (node:internal/timers:573:17) Jan 25 16:43:03 volumiopc13 volumio[1216]: at process.processTimers (node:internal/timers:514:7) Jan 25 16:43:03 volumiopc13 volumio[1216]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 16:43:03 volumiopc13 sudo[50059]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 16:42' Jan 25 16:43:03 volumiopc13 sudo[50059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"