-- Logs begin at Sat 2025-12-06 11:42:23 CET, end at Sat 2025-12-06 11:47:17 CET. -- Dec 06 11:46:05 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 06 11:46:06 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:46:11 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::ClearQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::stop Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::stPlaybackTimer Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::updateTrackBlock Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrackBlock Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::serviceStop Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::serviceStop Dec 06 11:46:11 rivoplus volumio[3292]: info: [1765017971626] ControllerWebradio::stop Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::clearPlayQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::saveQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::addQueueItems Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::addQueueItems Dec 06 11:46:11 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:46:11 rivoplus volumio[3292]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s183262 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::saveQueue Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::updateTrackBlock Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrackBlock Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPlay Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::play index 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::stop Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::play index undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::startPlaybackTimer Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: [1765017971664] ControllerWebradio::clearAddPlayTrack Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand stop took 54 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand stop took 18 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:11 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:11 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:11 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand status took 5 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand clear took 5 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand status took 3 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand load "https://maiban00.radioca.st/stream" Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:11 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 06 11:46:11 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:11 rivoplus volumio[3292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 06 11:46:11 rivoplus volumio[3292]: info: ------------------------------ 36ms Dec 06 11:46:11 rivoplus volumio[3292]: info: ------------------------------ 35ms Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:11 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:11 rivoplus volumio[3292]: info: Dec 06 11:46:11 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:11 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:11 rivoplus volumio[3292]: error: updateQueue error: null Dec 06 11:46:11 rivoplus volumio[3292]: info: ------------------------------ 38ms Dec 06 11:46:11 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 36 milliseconds Dec 06 11:46:11 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:11 rivoplus volumio[3292]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 06 11:46:11 rivoplus volumio[3292]: info: ------------------------------ 45ms Dec 06 11:46:11 rivoplus volumio[3292]: info: MCU Signalled Playback Inactive Dec 06 11:46:12 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand add "https://maiban00.radioca.st/stream" Dec 06 11:46:12 rivoplus volumio[3292]: error: updateQueue error: null Dec 06 11:46:12 rivoplus volumio[3292]: info: Dec 06 11:46:12 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:12 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:12 rivoplus volumio[3292]: info: ------------------------------ 985ms Dec 06 11:46:12 rivoplus volumio[3292]: info: ------------------------------ 984ms Dec 06 11:46:12 rivoplus volumio[3292]: info: sendMpdCommand add "https://maiban00.radioca.st/stream" took 2 milliseconds Dec 06 11:46:12 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 11:46:12 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand play Dec 06 11:46:12 rivoplus volumio[3292]: info: Dec 06 11:46:12 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:12 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:12 rivoplus volumio[3292]: info: Dec 06 11:46:12 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:12 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:12 rivoplus volumio[3292]: info: ------------------------------ 7ms Dec 06 11:46:12 rivoplus volumio[3292]: info: sendMpdCommand play took 5 milliseconds Dec 06 11:46:12 rivoplus volumio[3292]: info: ------------------------------ 4ms Dec 06 11:46:12 rivoplus volumio[3292]: info: ------------------------------ 3ms Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 13 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 17 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 18 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 31ms Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 16 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 2 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 86ms Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 86ms Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 53 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 52 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 52 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 141ms Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 127ms Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 126ms Dec 06 11:46:13 rivoplus volumio[3292]: info: Signalling Playback active due to playback status change Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:13 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:13 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:13 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:13 rivoplus volumio[3292]: info: Dec 06 11:46:13 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 8ms Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 6 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 6ms Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 5 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: ------------------------------ 4ms Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand status took 3 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:13 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:13 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:13 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:14 rivoplus volumio[3292]: info: ------------------------------ 75ms Dec 06 11:46:14 rivoplus volumio[3292]: info: ------------------------------ 74ms Dec 06 11:46:14 rivoplus volumio[3292]: info: ------------------------------ 73ms Dec 06 11:46:14 rivoplus volumio[3292]: info: MCU Signalled Playback Active Dec 06 11:46:15 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::ClearQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::stPlaybackTimer Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::updateTrackBlock Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrackBlock Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::serviceStop Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::serviceStop Dec 06 11:46:15 rivoplus volumio[3292]: info: [1765017975246] ControllerWebradio::stop Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::clearPlayQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::saveQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::addQueueItems Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::addQueueItems Dec 06 11:46:15 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:46:15 rivoplus volumio[3292]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s223154 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand stop took 51 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand status took 2 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: 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":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:15 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: No code Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: 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":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:15 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: No code Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: 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":"France Joli - Gonna get over you","artist":"DISCO STUDIO 54","album":null,"uri":"https://maiban00.radioca.st/stream","trackType":"st/stream"} Dec 06 11:46:15 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: No code Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:15 rivoplus volumio[3292]: info: ------------------------------ 103ms Dec 06 11:46:15 rivoplus volumio[3292]: info: ------------------------------ 104ms Dec 06 11:46:15 rivoplus volumio[3292]: info: ------------------------------ 103ms Dec 06 11:46:15 rivoplus volumio[3292]: info: MCU Signalled Playback Inactive Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::saveQueue Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::updateTrackBlock Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrackBlock Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPlay Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::play index 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::stop Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::play index undefined Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: CoreStateMachine::startPlaybackTimer Dec 06 11:46:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:15 rivoplus volumio[3292]: info: [1765017975663] ControllerWebradio::clearAddPlayTrack Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand stop took 4 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:15 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:15 rivoplus volumio[3292]: info: sendMpdCommand clear took 2 milliseconds Dec 06 11:46:15 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand load "http://mediaserv33.live-streams.nl:8036" Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:15 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:15 rivoplus volumio[3292]: info: Dec 06 11:46:15 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:15 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:15 rivoplus volumio[3292]: error: updateQueue error: null Dec 06 11:46:15 rivoplus volumio[3292]: info: ------------------------------ 5ms Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" Dec 06 11:46:16 rivoplus volumio[3292]: error: updateQueue error: null Dec 06 11:46:16 rivoplus volumio[3292]: error: updateQueue error: null Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 678ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 678ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" took 4 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand play Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 6ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand play took 5 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 4ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 2ms Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 85 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 87 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 85 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 93ms Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 8 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 2 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 145ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 144ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 50 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 49 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 50 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 123ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 118ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 118ms Dec 06 11:46:16 rivoplus volumio[3292]: info: Signalling Playback active due to playback status change Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 4ms Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 9 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 8ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 8 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 6ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 5 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 4ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 3 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces system playlist update Dec 06 11:46:16 rivoplus volumio[3292]: info: Ignoring MPD Status Update Dec 06 11:46:16 rivoplus volumio[3292]: info: Dec 06 11:46:16 rivoplus volumio[3292]: ---------------------------- MPD announces state update: player Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::getState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 14ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 5 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 5ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseState Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 113ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 111ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 109ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 108ms Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 86 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: info: sendMpdCommand playlistinfo took 86 milliseconds Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ControllerMpd::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0 Dec 06 11:46:16 rivoplus volumio[3292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Timewave - Outer Rim (Original Mix)","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Dec 06 11:46:16 rivoplus volumio[3292]: verbose: CURRENT POSITION 0 Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState stateService play Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:46:16 rivoplus volumio[3292]: info: Received an update from plugin. extracting info from payload Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreStateMachine::pushState Dec 06 11:46:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 154ms Dec 06 11:46:16 rivoplus volumio[3292]: info: ------------------------------ 147ms Dec 06 11:46:16 rivoplus volumio[3292]: info: MCU Signalled Playback Active Dec 06 11:46:24 rivoplus volumio[3292]: Searching all installed plugins Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: , search Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 06 11:46:24 rivoplus volumio[3292]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: webradio , search Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Dec 06 11:46:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Dec 06 11:46:25 rivoplus volumio[3292]: info: All search sources collected, pushing search results Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:25 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:26 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:26 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:26 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:26 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:26 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:29 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:29 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:29 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:30 rivoplus volumio[3292]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 06 11:46:39 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 06 11:46:39 rivoplus volumio[3292]: info: Preload queue cleared Dec 06 11:47:16 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Dec 06 11:47:16 rivoplus volumio[3292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 11:47:16 rivoplus volumio[3292]: TypeError: Cannot read property 'then' of undefined Dec 06 11:47:16 rivoplus volumio[3292]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Dec 06 11:47:16 rivoplus volumio[3292]: at Socket.emit (events.js:400:28) Dec 06 11:47:16 rivoplus volumio[3292]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 06 11:47:16 rivoplus volumio[3292]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 06 11:47:16 rivoplus volumio[3292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 11:47:17 rivoplus sudo[4334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-06 11:46 Dec 06 11:47:17 rivoplus sudo[4334]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:44:55 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="af8df74278231e4f9fb9f04db56c320f"