-- Logs begin at Sat 2025-03-15 02:58:19 UTC, end at Mon 2025-10-27 13:11:22 UTC. -- Oct 27 13:10:00 volumio volumio[1017]: info: VolumeController::SetAlsaVolume100 Oct 27 13:10:00 volumio volumio[1017]: null Oct 27 13:10:00 volumio volumio[1017]: info: VolumeController::Volume 100 Oct 27 13:10:00 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:00 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:00 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:00 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:00 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:00 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:21 volumio volumio[1017]: info: [1761570621215] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Oct 27 13:10:22 volumio volumio[1017]: info: [1761570622002] [RadioParadise] received new metadata: {"time":204,"artist":"T‐Bone Burnett","title":"River of Love","album":"T Bone Burnett","year":"1986","cover":"https://img.radioparadise.com/covers/l/B000002QWR.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000002QWR.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000002QWR.jpg"} Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:22 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:22 volumio volumio[1017]: info: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000002QWR.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"River of Love","title":"River of Love","artist":"T‐Bone Burnett","album":"T Bone Burnett","streaming":true,"disableUiControls":true,"duration":209,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 27 13:10:22 volumio volumio[1017]: info: CURRENT POSITION 393 Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Oct 27 13:10:22 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:22 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:22 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:22 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:22 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:22 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:22 volumio volumio[1017]: info: [1761570622102] [RadioParadise] setting new timer with duration of 209000 seconds. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:22 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:38 volumio volumio[1017]: info: VolumeController::SetAlsaVolume46 Oct 27 13:10:38 volumio volumio[1017]: null Oct 27 13:10:38 volumio volumio[1017]: info: VolumeController::Volume 46 Oct 27 13:10:38 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:38 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:38 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:38 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:38 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: VolumeController::SetAlsaVolume71 Oct 27 13:10:38 volumio volumio[1017]: null Oct 27 13:10:38 volumio volumio[1017]: info: VolumeController::Volume 71 Oct 27 13:10:38 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:38 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:38 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:38 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:38 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:38 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:39 volumio volumio[1017]: info: VolumeController::SetAlsaVolume36 Oct 27 13:10:39 volumio volumio[1017]: null Oct 27 13:10:39 volumio volumio[1017]: info: VolumeController::Volume 36 Oct 27 13:10:39 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:39 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:39 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:39 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:39 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:39 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:39 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:39 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:39 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: VolumeController::SetAlsaVolume48 Oct 27 13:10:40 volumio volumio[1017]: null Oct 27 13:10:40 volumio volumio[1017]: info: VolumeController::Volume 48 Oct 27 13:10:40 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:40 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:40 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:40 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:40 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: VolumeController::SetAlsaVolume0 Oct 27 13:10:40 volumio volumio[1017]: null Oct 27 13:10:40 volumio volumio[1017]: info: VolumeController::Volume 0 Oct 27 13:10:40 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:40 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:40 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:40 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:40 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:40 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:41 volumio volumio[1017]: info: VolumeController::SetAlsaVolume100 Oct 27 13:10:41 volumio volumio[1017]: null Oct 27 13:10:41 volumio volumio[1017]: info: VolumeController::Volume 100 Oct 27 13:10:41 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:41 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:41 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:41 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:41 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:41 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:41 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:41 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:41 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:42 volumio volumio[1017]: info: VolumeController::SetAlsaVolume99 Oct 27 13:10:42 volumio volumio[1017]: null Oct 27 13:10:42 volumio volumio[1017]: info: VolumeController::Volume 99 Oct 27 13:10:42 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:42 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:42 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:42 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:42 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:42 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:42 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:42 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:42 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::volumioAddQueueItems Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::addQueueItems Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::addQueueItems Oct 27 13:10:49 volumio volumio[1017]: info: Adding Item to queue: webrp/3 Oct 27 13:10:49 volumio volumio[1017]: info: Exploding uri webrp/3 in service radio_paradise Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::saveQueue Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::volumioPushQueue Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::volumioPlay Oct 27 13:10:49 volumio volumio[1017]: UNSET VOLATILE Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::play index 394 Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::stop Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 13:10:49 volumio volumio[1017]: UNSET VOLATILE Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:49 volumio volumio[1017]: info: CoreStateMachine::serviceStop Oct 27 13:10:49 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:49 volumio volumio[1017]: info: CoreCommandRouter::serviceStop Oct 27 13:10:49 volumio volumio[1017]: info: ControllerMpd::stop Oct 27 13:10:49 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand stop Oct 27 13:10:49 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: Oct 27 13:10:50 volumio volumio[1017]: ---------------------------- MPD announces state update: player Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::getState Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand status Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:50 volumio volumio[1017]: info: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000002QWR.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"River of Love","title":"River of Love","artist":"T‐Bone Burnett","album":"T Bone Burnett","streaming":true,"disableUiControls":true,"duration":209,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 27 13:10:50 volumio volumio[1017]: info: CURRENT POSITION 393 Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:50 volumio volumio[1017]: info: No code Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 393 Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::play index undefined Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::startPlaybackTimer Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand stop Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::parseState Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand clear Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: Oct 27 13:10:50 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Oct 27 13:10:50 volumio volumio[1017]: info: Ignoring MPD Status Update Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::parseTrackInfo Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand consume 1 Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::pushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:50 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:50 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:50 volumio volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: ------------------------------ 299ms Oct 27 13:10:50 volumio volumio[1017]: info: Oct 27 13:10:50 volumio volumio[1017]: info: ------------------------------ 69ms Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: [1761570650659] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/world-etc-flac Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/world-etc-flac" Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: Oct 27 13:10:50 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Oct 27 13:10:50 volumio volumio[1017]: info: Ignoring MPD Status Update Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand play Oct 27 13:10:50 volumio volumio[1017]: info: sending command... Oct 27 13:10:50 volumio volumio[1017]: info: ------------------------------ 26ms Oct 27 13:10:50 volumio volumio[1017]: info: parsing response... Oct 27 13:10:50 volumio volumio[1017]: info: [1761570650718] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=3 Oct 27 13:10:51 volumio volumio[1017]: info: [1761570651645] [RadioParadise] received new metadata: {"time":119,"artist":"Gipsy Kings","title":"Faena","album":"Gipsy Kings","year":"1988","cover":"https://img.radioparadise.com/covers/l/B000002H6X.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000002H6X.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000002H6X.jpg"} Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:51 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:51 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:51 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:51 volumio volumio[1017]: info: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000002H6X.jpg","uri":"https://stream.radioparadise.com/world-etc-flac","name":"Faena","title":"Faena","artist":"Gipsy Kings","album":"Gipsy Kings","streaming":true,"disableUiControls":true,"duration":124,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 27 13:10:51 volumio volumio[1017]: info: CURRENT POSITION 394 Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::pushState Oct 27 13:10:51 volumio volumio[1017]: info: CoreStateMachine::getState Oct 27 13:10:51 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:51 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Oct 27 13:10:51 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 13:10:51 volumio volumio[1017]: info: [1761570651704] [RadioParadise] setting new timer with duration of 124000 seconds. Oct 27 13:10:51 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:51 volumio volumio[1017]: info: CorePlayQueue::getTrack 395 Oct 27 13:10:51 volumio volumio[1017]: info: [LastFM] configuration error; "API_KEY" is not set. Oct 27 13:10:51 volumio volumio[1017]: info: [LastFM] configuration error; "API_SECRET" is not set. Oct 27 13:10:51 volumio volumio[1017]: info: [LastFM] configuration error; "username" is not set. Oct 27 13:10:51 volumio volumio[1017]: info: [LastFM] configuration error; "authToken" is not set. Oct 27 13:10:52 volumio volumio[1017]: info: Oct 27 13:10:52 volumio volumio[1017]: ---------------------------- MPD announces state update: player Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::getState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand status Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: Oct 27 13:10:52 volumio volumio[1017]: ---------------------------- MPD announces state update: player Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::getState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand status Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: Oct 27 13:10:52 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Oct 27 13:10:52 volumio volumio[1017]: info: Ignoring MPD Status Update Oct 27 13:10:52 volumio volumio[1017]: info: Oct 27 13:10:52 volumio volumio[1017]: ---------------------------- MPD announces state update: player Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::getState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand status Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseTrackInfo Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::pushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:52 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:52 volumio volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 27 13:10:52 volumio volumio[1017]: info: ------------------------------ 63ms Oct 27 13:10:52 volumio volumio[1017]: info: ------------------------------ 23ms Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseState Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseTrackInfo Oct 27 13:10:52 volumio volumio[1017]: info: sending command... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::pushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:52 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:52 volumio volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 27 13:10:52 volumio volumio[1017]: info: ------------------------------ 42ms Oct 27 13:10:52 volumio volumio[1017]: info: parsing response... Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::parseTrackInfo Oct 27 13:10:52 volumio volumio[1017]: info: ControllerMpd::pushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Oct 27 13:10:52 volumio volumio[1017]: info: CoreStateMachine::syncState Oct 27 13:10:52 volumio volumio[1017]: info: CorePlayQueue::getTrack 394 Oct 27 13:10:52 volumio volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 27 13:10:52 volumio volumio[1017]: info: ------------------------------ 36ms Oct 27 13:10:52 volumio volumio[1017]: info: No input data Oct 27 13:10:55 volumio volumio[1017]: info: No input data Oct 27 13:10:55 volumio volumio[1017]: info: No input data Oct 27 13:11:20 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: pandora , handleBrowseUri Oct 27 13:11:20 volumio volumio[1017]: info: [1761570680317] ControllerPandora::handleBrowseUri Oct 27 13:11:20 volumio volumio[1017]: info: [1761570680319] ControllerPandora::checkForExpiredStations Oct 27 13:11:20 volumio volumio[1017]: info: [1761570680320] [Pandora] checkForExpiredStations: Stations expired Oct 27 13:11:20 volumio volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 13:11:20 volumio volumio[1017]: TypeError: Cannot read property 'fillStationData' of undefined Oct 27 13:11:20 volumio volumio[1017]: at ControllerPandora.checkForExpiredStations (/data/plugins/music_service/pandora/index.js:819:36) Oct 27 13:11:20 volumio volumio[1017]: at ControllerPandora.handleBrowseUri (/data/plugins/music_service/pandora/index.js:421:17) Oct 27 13:11:20 volumio volumio[1017]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1013:29) Oct 27 13:11:20 volumio volumio[1017]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:328:47) Oct 27 13:11:20 volumio volumio[1017]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:354:32) Oct 27 13:11:20 volumio volumio[1017]: at emitTwo (events.js:126:13) Oct 27 13:11:20 volumio volumio[1017]: at Socket.emit (events.js:214:7) Oct 27 13:11:20 volumio volumio[1017]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 27 13:11:20 volumio volumio[1017]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 27 13:11:20 volumio volumio[1017]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 27 13:11:20 volumio volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 13:11:22 volumio sudo[3880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 13:10 Oct 27 13:11:22 volumio sudo[3880]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7124eaf0213deb060cebb17ef631669189a6650e" VOLUMIO_FE_VERSION="b52b5dfa93e3b26d6f23f09c91a5b90b0a43edf0" VOLUMIO_BE_VERSION="273d2050e44b6f5ae901d967e346577f7ad86f2c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Aug 27 17:21:50 CEST 2018" VOLUMIO_VERSION="2.452" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1802c403029d39af3072f40e987e7ba4"