-- Logs begin at Fri 2024-08-16 13:20:40 UTC, end at Fri 2024-08-16 15:05:25 UTC. -- Aug 16 15:04:04 volumio volumio[937]: info: Aug 16 15:04:04 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:04:04 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:04:04 volumio volumio[937]: info: Aug 16 15:04:04 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:04:04 volumio volumio[937]: info: sendMpdCommand status took 36 milliseconds Aug 16 15:04:04 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:04:04 volumio volumio[937]: info: Aug 16 15:04:04 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:04:04 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:04:04 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Aug 16 15:04:04 volumio volumio[937]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:04:04 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:04:04 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:04:04 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:04 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 16 15:04:04 volumio volumio[937]: info: ------------------------------ 54ms Aug 16 15:04:04 volumio volumio[937]: info: ------------------------------ 11ms Aug 16 15:04:04 volumio volumio[937]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 16 15:04:04 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:04:04 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:04:04 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:04:04 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:04 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 16 15:04:04 volumio volumio[937]: info: ------------------------------ 22ms Aug 16 15:04:05 volumio volumio[937]: info: VolumeController::SetAlsaVolume55 Aug 16 15:04:05 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:04:05 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:05 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:04:05 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:04:21 volumio volumio[937]: info: Enabling plugin rad357pl Aug 16 15:04:21 volumio volumio[937]: info: Loading plugin "rad357pl"... Aug 16 15:04:22 volumio volumio[937]: info: [1723820662228] [rad357pl] API delay: 5 Aug 16 15:04:22 volumio volumio[937]: info: PLUGIN START: rad357pl Aug 16 15:04:22 volumio volumio[937]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 16 15:04:22 volumio volumio[937]: info: [1723820662235] CoreMusicLibrary::Adding element RADIO 357 Aug 16 15:04:22 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 16 15:04:22 volumio volumio[937]: info: Done. Aug 16 15:04:23 volumio volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 16 15:04:28 volumio volumio[937]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Aug 16 15:04:29 volumio volumio[937]: info: Enabling plugin personal_radio Aug 16 15:04:29 volumio volumio[937]: info: Loading plugin "personal_radio"... Aug 16 15:04:30 volumio volumio[937]: info: ControllerPersonalRadio::constructor Aug 16 15:04:30 volumio volumio[937]: info: PLUGIN START: personal_radio Aug 16 15:04:30 volumio volumio[937]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 16 15:04:30 volumio volumio[937]: info: [1723820670045] CoreMusicLibrary::Adding element Personal Radio Aug 16 15:04:30 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 16 15:04:30 volumio volumio[937]: info: Done. Aug 16 15:04:30 volumio volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 16 15:04:34 volumio volumio[937]: info: Enabling plugin nowyswiat Aug 16 15:04:34 volumio volumio[937]: info: Loading plugin "nowyswiat"... Aug 16 15:04:34 volumio volumio[937]: info: [1723820674547] [RadioNowySwiat] API delay: 5 Aug 16 15:04:34 volumio volumio[937]: info: [1723820674547] [RadioNowySwiat] Stream 256Kb: http://stream.rcs.revma.com/ypqt40u0x1zuv Aug 16 15:04:34 volumio volumio[937]: info: PLUGIN START: nowyswiat Aug 16 15:04:34 volumio volumio[937]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 16 15:04:34 volumio volumio[937]: info: [1723820674553] CoreMusicLibrary::Adding element Radio Nowy Swiat Aug 16 15:04:34 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 16 15:04:34 volumio volumio[937]: info: Done. Aug 16 15:04:35 volumio volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 16 15:04:35 volumio volumio[937]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Aug 16 15:04:38 volumio volumio[937]: info: Aug 16 15:04:38 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:04:38 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:04:38 volumio volumio[937]: info: Aug 16 15:04:38 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:04:38 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:04:38 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:04:38 volumio volumio[937]: error: updateQueue error: null Aug 16 15:04:38 volumio volumio[937]: info: ------------------------------ 4ms Aug 16 15:04:38 volumio volumio[937]: info: sendMpdCommand status took 3 milliseconds Aug 16 15:04:38 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:04:38 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:04:38 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:04:38 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:04:38 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:38 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:04:38 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:04:38 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:38 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 16 15:04:38 volumio volumio[937]: info: ------------------------------ 15ms Aug 16 15:04:42 volumio volumio[937]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Aug 16 15:04:42 volumio volumio[937]: info: Enabling plugin hotelradio Aug 16 15:04:42 volumio volumio[937]: info: Loading plugin "hotelradio"... Aug 16 15:04:43 volumio volumio[937]: info: PLUGIN START: hotelradio Aug 16 15:04:43 volumio volumio[937]: info: Done. Aug 16 15:04:43 volumio volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 16 15:04:48 volumio volumio[937]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::volumioGetState Aug 16 15:04:59 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::volumioGetVisibleSources Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 16 15:04:59 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 16 15:05:01 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 16 15:05:01 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 16 15:05:03 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: nowyswiat , handleBrowseUri Aug 16 15:05:03 volumio volumio[937]: info: [1723820703154] [RadioNowySwiat] handleBrowseUri curUri: nowyswiat Aug 16 15:05:03 volumio volumio[937]: info: [1723820703155] [RadioNowySwiat] getRadioContent url: nowyswiat Aug 16 15:05:03 volumio volumio[937]: info: CoreCommandRouter::volumioGetQueue Aug 16 15:05:03 volumio volumio[937]: info: CoreStateMachine::getQueue Aug 16 15:05:03 volumio volumio[937]: info: CorePlayQueue::getQueue Aug 16 15:05:03 volumio volumio[937]: info: Listing playlists Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::ClearQueue Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::stop Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 16 15:05:05 volumio volumio[937]: verbose: UNSET VOLATILE Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::serviceStop Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::serviceStop Aug 16 15:05:05 volumio volumio[937]: info: ControllerMpd::stop Aug 16 15:05:05 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::saveQueue Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Aug 16 15:05:05 volumio volumio[937]: info: CoreStateMachine::addQueueItems Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::addQueueItems Aug 16 15:05:05 volumio volumio[937]: info: Adding Item to queue: webrns/1 Aug 16 15:05:05 volumio volumio[937]: info: Exploding uri webrns/1 in service nowyswiat Aug 16 15:05:05 volumio volumio[937]: info: [ ================== >>>> ] [RADIONOWYSWIAT] explodeUri: webrns/1 Aug 16 15:05:05 volumio volumio[937]: info: [ ================== >>>> ] [RADIONOWYSWIAT] channel: 1 Aug 16 15:05:05 volumio volumio[937]: info: [ ================== >>>> ] [RADIONOWYSWIAT] RNS_Link: http://stream.rcs.revma.com/ypqt40u0x1zuv Aug 16 15:05:05 volumio volumio[937]: info: CorePlayQueue::saveQueue Aug 16 15:05:05 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Aug 16 15:05:06 volumio volumio[937]: verbose: UNSET VOLATILE Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::play index 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::stop Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 16 15:05:06 volumio volumio[937]: verbose: UNSET VOLATILE Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::play index undefined Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: info: [ ================== >>>> ] [RADIONOWYSWIAT] Stream 256Kb: http://stream.rcs.revma.com/ypqt40u0x1zuv Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand stop took 57 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand stop took 19 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current nowyswiat Received radio_paradise Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:05:06 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand clear took 8 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" Aug 16 15:05:06 volumio volumio[937]: error: updateQueue error: null Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:05:06 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 4ms Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" took 3 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 6ms Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand play took 2 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand status took 37 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:05:06 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: 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":"ypqt40u0x1zuv","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Aug 16 15:05:06 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 76ms Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces system playlist update Aug 16 15:05:06 volumio volumio[937]: info: Ignoring MPD Status Update Aug 16 15:05:06 volumio volumio[937]: info: Aug 16 15:05:06 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 36ms Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand status took 35 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":417,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Aug 16 15:05:06 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 16 15:05:06 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 80ms Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 55ms Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand status took 51 milliseconds Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand playlistinfo took 48 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Aug 16 15:05:06 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 16 15:05:06 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 120ms Aug 16 15:05:06 volumio volumio[937]: info: sendMpdCommand playlistinfo took 31 milliseconds Aug 16 15:05:06 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:05:06 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:06 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:06 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Aug 16 15:05:06 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 16 15:05:06 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:06 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:06 volumio volumio[937]: info: ------------------------------ 110ms Aug 16 15:05:08 volumio volumio[937]: info: VolumeController::SetAlsaVolume50 Aug 16 15:05:08 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:08 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:08 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:15 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Aug 16 15:05:15 volumio volumio[937]: info: ControllerPersonalRadio::handleBrowseUri Aug 16 15:05:17 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 16 15:05:17 volumio volumio[937]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 16 15:05:17 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 16 15:05:17 volumio volumio[937]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Aug 16 15:05:17 volumio volumio[937]: info: Received Get System Version Aug 16 15:05:17 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 16 15:05:19 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Aug 16 15:05:19 volumio volumio[937]: info: ControllerPersonalRadio::handleBrowseUri Aug 16 15:05:21 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Aug 16 15:05:21 volumio volumio[937]: info: ControllerPersonalRadio::handleBrowseUri Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::ClearQueue Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::stop Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 16 15:05:23 volumio volumio[937]: verbose: UNSET VOLATILE Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::serviceStop Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::serviceStop Aug 16 15:05:23 volumio volumio[937]: info: ControllerMpd::stop Aug 16 15:05:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::saveQueue Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::addQueueItems Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::addQueueItems Aug 16 15:05:23 volumio volumio[937]: info: Adding Item to queue: webmbc/0 Aug 16 15:05:23 volumio volumio[937]: info: Exploding uri webmbc/0 in service personal_radio Aug 16 15:05:23 volumio volumio[937]: info: sendMpdCommand stop took 89 milliseconds Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop"} Aug 16 15:05:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: No code Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: Aug 16 15:05:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Aug 16 15:05:23 volumio volumio[937]: info: ControllerMpd::getState Aug 16 15:05:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 16 15:05:23 volumio volumio[937]: info: sendMpdCommand status took 16 milliseconds Aug 16 15:05:23 volumio volumio[937]: verbose: ControllerMpd::parseState Aug 16 15:05:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 16 15:05:23 volumio volumio[937]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 16 15:05:23 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 16 15:05:23 volumio volumio[937]: info: ControllerMpd::pushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: 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":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Aug 16 15:05:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: No code Aug 16 15:05:23 volumio volumio[937]: info: CoreStateMachine::pushState Aug 16 15:05:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Aug 16 15:05:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 15:05:23 volumio volumio[937]: info: ------------------------------ 49ms Aug 16 15:05:24 volumio volumio[937]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 16 15:05:24 volumio volumio[937]: TypeError: Cannot read property 'replace' of undefined Aug 16 15:05:24 volumio volumio[937]: at /data/plugins/music_service/personal_radio/index.js:499:45 Aug 16 15:05:24 volumio volumio[937]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:463:26) Aug 16 15:05:24 volumio volumio[937]: at Request.self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Aug 16 15:05:24 volumio volumio[937]: at emitTwo (events.js:126:13) Aug 16 15:05:24 volumio volumio[937]: at Request.emit (events.js:214:7) Aug 16 15:05:24 volumio volumio[937]: at Request. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:1044:10) Aug 16 15:05:24 volumio volumio[937]: at emitOne (events.js:116:13) Aug 16 15:05:24 volumio volumio[937]: at Request.emit (events.js:211:7) Aug 16 15:05:24 volumio volumio[937]: at IncomingMessage. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:965:12) Aug 16 15:05:24 volumio volumio[937]: at emitNone (events.js:111:20) Aug 16 15:05:24 volumio volumio[937]: at IncomingMessage.emit (events.js:208:7) Aug 16 15:05:24 volumio volumio[937]: at endReadableNT (_stream_readable.js:1064:12) Aug 16 15:05:24 volumio volumio[937]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Aug 16 15:05:24 volumio volumio[937]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 16 15:05:24 volumio volumio[937]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 16 15:05:25 volumio sudo[16383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-16 15:04 Aug 16 15:05:25 volumio sudo[16383]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"